builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-007 starttime: 1451426306.16 results: success (0) buildid: 20151229113008 builduid: 520878e0fc9240998613eb83f6dc1ccc revision: 7d1b18c49d6599ec982477034e86c721ff7cff23 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:26.159663) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:26.163634) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:26.164325) ========= 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=6ef107882637bc5fc02d78b7000001c2-1451425947.489452-506125225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006274 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.08 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:26.253538) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:26.254161) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:26.379420) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:26.379992) ========= 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=6ef107882637bc5fc02d78b7000001c2-1451425947.489452-506125225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014296 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:26.477731) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:26.478380) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:26.479037) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:26.479547) ========= 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=6ef107882637bc5fc02d78b7000001c2-1451425947.489452-506125225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-29 13:58:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2015-12-29 13:58:26 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181030 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:26.688285) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:26.688670) ========= 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=6ef107882637bc5fc02d78b7000001c2-1451425947.489452-506125225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.111120 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:26.809202) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:26.809608) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7d1b18c49d6599ec982477034e86c721ff7cff23 --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 7d1b18c49d6599ec982477034e86c721ff7cff23 --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=6ef107882637bc5fc02d78b7000001c2-1451425947.489452-506125225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-29 13:58:26,948 truncating revision to first 12 chars 2015-12-29 13:58:26,948 Setting DEBUG logging. 2015-12-29 13:58:26,948 attempt 1/10 2015-12-29 13:58:26,948 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7d1b18c49d65?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-29 13:58:27,188 unpacking tar archive at: fx-team-7d1b18c49d65/testing/mozharness/ program finished with exit code 0 elapsedTime=0.571395 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:27.395082) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:27.395641) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:27.406714) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:27.407087) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:27.407527) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-29 13:58:27.407809) ========= /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=6ef107882637bc5fc02d78b7000001c2-1451425947.489452-506125225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:58:27 INFO - MultiFileLogger online at 20151229 13:58:27 in /builds/slave/test-pgo 13:58:27 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 13:58:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:58:27 INFO - {'append_to_log': False, 13:58:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:58:27 INFO - 'blob_upload_branch': 'Fx-Team', 13:58:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:58:27 INFO - 'branch': 'Fx-Team', 13:58:27 INFO - 'buildbot_json_path': 'buildprops.json', 13:58:27 INFO - 'config_files': ('talos/linux_config.py',), 13:58:27 INFO - 'default_actions': ('clobber', 13:58:27 INFO - 'read-buildbot-config', 13:58:27 INFO - 'download-and-extract', 13:58:27 INFO - 'populate-webroot', 13:58:27 INFO - 'create-virtualenv', 13:58:27 INFO - 'install', 13:58:27 INFO - 'run-tests'), 13:58:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:58:27 INFO - 'download_minidump_stackwalk': True, 13:58:27 INFO - 'download_symbols': 'ondemand', 13:58:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:58:27 INFO - 'tooltool.py': '/tools/tooltool.py', 13:58:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:58:27 INFO - '/tools/misc-python/virtualenv.py')}, 13:58:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:58:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:58:27 INFO - 'installer_path': 'installer.exe', 13:58:27 INFO - 'log_level': 'info', 13:58:27 INFO - 'log_name': 'talos', 13:58:27 INFO - 'log_to_console': True, 13:58:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:58:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:58:27 INFO - 'opt_config_files': (), 13:58:27 INFO - 'pip_index': False, 13:58:27 INFO - 'sps_profile': False, 13:58:27 INFO - 'sps_profile_interval': 0, 13:58:27 INFO - 'suite': 'dromaeojs-e10s', 13:58:27 INFO - 'system_bits': '32', 13:58:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:58:27 INFO - 'title': 'talos-linux64-ix-007', 13:58:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:58:27 INFO - 'use_talos_json': True, 13:58:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:58:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:58:27 INFO - 'work_dir': 'build'} 13:58:27 INFO - ##### 13:58:27 INFO - ##### Running clobber step. 13:58:27 INFO - ##### 13:58:27 INFO - Running pre-action listener: _resource_record_pre_action 13:58:27 INFO - Running main action method: clobber 13:58:27 INFO - rmtree: /builds/slave/test-pgo/build 13:58:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:58:28 INFO - Running post-action listener: _resource_record_post_action 13:58:28 INFO - ##### 13:58:28 INFO - ##### Running read-buildbot-config step. 13:58:28 INFO - ##### 13:58:28 INFO - Running pre-action listener: _resource_record_pre_action 13:58:28 INFO - Running main action method: read_buildbot_config 13:58:28 INFO - Using buildbot properties: 13:58:28 INFO - { 13:58:28 INFO - "project": "", 13:58:28 INFO - "product": "firefox", 13:58:28 INFO - "script_repo_revision": "production", 13:58:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 13:58:28 INFO - "repository": "", 13:58:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 13:58:28 INFO - "buildid": "20151229113008", 13:58:28 INFO - "pgo_build": "True", 13:58:28 INFO - "basedir": "/builds/slave/test-pgo", 13:58:28 INFO - "buildnumber": 162, 13:58:28 INFO - "slavename": "talos-linux64-ix-007", 13:58:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:58:28 INFO - "platform": "ubuntu64_hw", 13:58:28 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 13:58:28 INFO - "branch": "fx-team", 13:58:28 INFO - "repo_path": "integration/fx-team", 13:58:28 INFO - "revision": "7d1b18c49d6599ec982477034e86c721ff7cff23", 13:58:28 INFO - "stage_platform": "linux64-pgo", 13:58:28 INFO - "builduid": "520878e0fc9240998613eb83f6dc1ccc", 13:58:28 INFO - "slavebuilddir": "test" 13:58:28 INFO - } 13:58:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 13:58:28 INFO - Running post-action listener: _resource_record_post_action 13:58:28 INFO - ##### 13:58:28 INFO - ##### Running download-and-extract step. 13:58:28 INFO - ##### 13:58:28 INFO - Running pre-action listener: _resource_record_pre_action 13:58:28 INFO - Running main action method: download_and_extract 13:58:28 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:58: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')]} 13:58:28 INFO - https://queue.taskcluster.net/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:58:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/test_packages.json 13:58:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/test_packages.json 13:58:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 13:58:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 13:58:30 INFO - Downloaded 1302 bytes. 13:58:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 13:58:30 INFO - Using the following test package requirements: 13:58:30 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:58:30 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:58:30 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:30 INFO - u'jsshell-linux-x86_64.zip'], 13:58:30 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:58:30 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:58:30 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:58:30 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:58:30 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:58:30 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:58:30 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:58:30 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:30 INFO - https://queue.taskcluster.net/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:58:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:58:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:58:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/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 13:58:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/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 13:58:33 INFO - Downloaded 23192569 bytes. 13:58:33 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 13:58:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:58:33 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 13:58:35 INFO - Return code: 0 13:58:35 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 13:58:35 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')]} 13:58:35 INFO - https://queue.taskcluster.net/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:58:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:58:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:58:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/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 13:58:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/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 13:58:36 INFO - Downloaded 23192569 bytes. 13:58:36 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 13:58:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:58:36 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 13:58:37 INFO - Return code: 0 13:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:37 INFO - https://queue.taskcluster.net/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:58:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:58:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:58:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/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 13:58:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/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 13:58:38 INFO - Downloaded 11132270 bytes. 13:58:38 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 13:58:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:58:38 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 13:58:39 INFO - Return code: 0 13:58:39 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')]} 13:58:39 INFO - https://queue.taskcluster.net/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:58:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:58:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:58:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/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 13:58:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/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 13:58:40 INFO - Downloaded 54893147 bytes. 13:58:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:58:40 INFO - mkdir: /builds/slave/test-pgo/properties 13:58:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:58:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:58:40 INFO - Contents: 13:58:40 INFO - build_url:https://queue.taskcluster.net/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:58:40 INFO - Running post-action listener: _resource_record_post_action 13:58:40 INFO - Running post-action listener: set_extra_try_arguments 13:58:40 INFO - ##### 13:58:40 INFO - ##### Running populate-webroot step. 13:58:40 INFO - ##### 13:58:40 INFO - Running pre-action listener: _resource_record_pre_action 13:58:40 INFO - Running main action method: populate_webroot 13:58:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:58:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:58:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:58:40 INFO - '--tppagecycles', 13:58:40 INFO - '7'], 13:58:40 INFO - 'tests': ['tsvgm']}}, 13:58:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:58:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:58:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:58:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:58:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:58:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:58:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:58:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:40 INFO - 'talos_options': ['--e10s'], 13:58:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:58:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:40 INFO - 'tests': ['damp', 'tps']}, 13:58:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:40 INFO - 'talos_options': ['--e10s'], 13:58:40 INFO - 'tests': ['damp', 'tps']}, 13:58:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:58:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:58:40 INFO - 'other': {'tests': ['a11yr', 13:58:40 INFO - 'ts_paint', 13:58:40 INFO - 'tpaint', 13:58:40 INFO - 'sessionrestore', 13:58:40 INFO - 'sessionrestore_no_auto_restore']}, 13:58:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:58:40 INFO - 'tests': ['a11yr', 13:58:40 INFO - 'ts_paint', 13:58:40 INFO - 'tpaint', 13:58:40 INFO - 'sessionrestore', 13:58:40 INFO - 'sessionrestore_no_auto_restore']}, 13:58:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:58:40 INFO - 'tests': ['a11yr', 13:58:40 INFO - 'ts_paint', 13:58:40 INFO - 'tpaint', 13:58:40 INFO - 'sessionrestore', 13:58:40 INFO - 'sessionrestore_no_auto_restore']}, 13:58:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:58:40 INFO - 'tests': ['a11yr', 13:58:40 INFO - 'ts_paint', 13:58:40 INFO - 'tpaint', 13:58:40 INFO - 'sessionrestore', 13:58:40 INFO - 'sessionrestore_no_auto_restore']}, 13:58:40 INFO - 'other_l64': {'tests': ['a11yr', 13:58:40 INFO - 'ts_paint', 13:58:40 INFO - 'tpaint', 13:58:40 INFO - 'sessionrestore', 13:58:40 INFO - 'sessionrestore_no_auto_restore']}, 13:58:40 INFO - 'other_nol64': {'tests': ['a11yr', 13:58:40 INFO - 'ts_paint', 13:58:40 INFO - 'tpaint', 13:58:40 INFO - 'sessionrestore', 13:58:40 INFO - 'sessionrestore_no_auto_restore']}, 13:58:40 INFO - 'svgr': {'tests': ['tsvgx', 13:58:40 INFO - 'tsvgr_opacity', 13:58:40 INFO - 'tart', 13:58:40 INFO - 'tscrollx', 13:58:40 INFO - 'cart']}, 13:58:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:58:40 INFO - 'tests': ['tsvgx', 13:58:40 INFO - 'tsvgr_opacity', 13:58:40 INFO - 'tart', 13:58:40 INFO - 'tscrollx', 13:58:40 INFO - 'cart']}, 13:58:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:40 INFO - 'tests': ['tp5o']}, 13:58:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:40 INFO - 'talos_options': ['--e10s'], 13:58:40 INFO - 'tests': ['tp5o']}, 13:58:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:40 INFO - 'talos_options': ['--xperf_path', 13:58:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:58:40 INFO - 'tests': ['tp5n']}, 13:58:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:40 INFO - 'talos_options': ['--e10s', 13:58:40 INFO - '--xperf_path', 13:58:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:58:40 INFO - 'tests': ['tp5n']}}, 13:58:40 INFO - 'talos.zip': {'path': '', 13:58:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:58:40 INFO - Running post-action listener: _resource_record_post_action 13:58:40 INFO - ##### 13:58:40 INFO - ##### Running create-virtualenv step. 13:58:40 INFO - ##### 13:58:40 INFO - Running pre-action listener: _resource_record_pre_action 13:58:40 INFO - Running main action method: create_virtualenv 13:58:40 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:58:40 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 13:58:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:58:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:58:40 INFO - Using real prefix '/usr' 13:58:40 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:58:40 INFO - Installing distribute.............................................................................................................................................................................................done. 13:58:42 INFO - Installing pip.................done. 13:58:42 INFO - Return code: 0 13:58:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:58:42 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')]} 13:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:42 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')]} 13:58:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:42 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 0x7f6d96193f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc13f0>, '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 0x1d53560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d53a10>, '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': '6ef107882637bc5fc02d78b7000001c2-1451425947.489452-506125225', '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 13:58:42 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 13:58:42 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 13:58:42 INFO - Using env: {'DISPLAY': ':0', 13:58:42 INFO - 'HOME': '/home/cltbld', 13:58:42 INFO - 'LANG': 'en_US.UTF-8', 13:58:42 INFO - 'LANGUAGE': 'en_US:en', 13:58:42 INFO - 'LOGNAME': 'cltbld', 13:58:42 INFO - 'MAIL': '/var/mail/cltbld', 13:58:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:42 INFO - 'MOZ_NO_REMOTE': '1', 13:58:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:42 INFO - 'NO_EM_RESTART': '1', 13:58:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:58:42 INFO - 'PWD': '/builds/slave/test-pgo', 13:58:42 INFO - 'SHELL': '/bin/bash', 13:58:42 INFO - 'SHLVL': '1', 13:58:42 INFO - 'TERM': 'linux', 13:58:42 INFO - 'TMOUT': '86400', 13:58:42 INFO - 'USER': 'cltbld', 13:58:42 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1451425947.489452-506125225', 13:58:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:42 INFO - '_': '/tools/buildbot/bin/python'} 13:58:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:43 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 13:58:43 INFO - Cleaning up... 13:58:43 INFO - Return code: 0 13:58:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:58:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:43 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 0x7f6d96193f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc13f0>, '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 0x1d53560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d53a10>, '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': '6ef107882637bc5fc02d78b7000001c2-1451425947.489452-506125225', '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 13:58:43 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 13:58:43 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 13:58:43 INFO - Using env: {'DISPLAY': ':0', 13:58:43 INFO - 'HOME': '/home/cltbld', 13:58:43 INFO - 'LANG': 'en_US.UTF-8', 13:58:43 INFO - 'LANGUAGE': 'en_US:en', 13:58:43 INFO - 'LOGNAME': 'cltbld', 13:58:43 INFO - 'MAIL': '/var/mail/cltbld', 13:58:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:43 INFO - 'MOZ_NO_REMOTE': '1', 13:58:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:43 INFO - 'NO_EM_RESTART': '1', 13:58:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:58:43 INFO - 'PWD': '/builds/slave/test-pgo', 13:58:43 INFO - 'SHELL': '/bin/bash', 13:58:43 INFO - 'SHLVL': '1', 13:58:43 INFO - 'TERM': 'linux', 13:58:43 INFO - 'TMOUT': '86400', 13:58:43 INFO - 'USER': 'cltbld', 13:58:43 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1451425947.489452-506125225', 13:58:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:43 INFO - '_': '/tools/buildbot/bin/python'} 13:58:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:43 INFO - Downloading/unpacking psutil>=0.7.1 13:58:43 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 13:58:43 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 13:58:43 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 13:58:43 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 13:58:43 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 13:58:43 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 13:58:44 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 13:58:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:58:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:58:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:58:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:58:45 INFO - Installing collected packages: psutil 13:58:45 INFO - Running setup.py install for psutil 13:58:45 INFO - building 'psutil._psutil_linux' extension 13:58:45 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 13:58:45 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 13:58:45 INFO - building 'psutil._psutil_posix' extension 13:58:45 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 13:58:45 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 13:58:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:58:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:58:45 INFO - Successfully installed psutil 13:58:45 INFO - Cleaning up... 13:58:45 INFO - Return code: 0 13:58:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:58: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')]} 13:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58: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')]} 13:58:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:45 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 0x7f6d96193f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc13f0>, '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 0x1d53560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d53a10>, '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': '6ef107882637bc5fc02d78b7000001c2-1451425947.489452-506125225', '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 13:58:45 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 13:58:45 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 13:58:45 INFO - Using env: {'DISPLAY': ':0', 13:58:45 INFO - 'HOME': '/home/cltbld', 13:58:45 INFO - 'LANG': 'en_US.UTF-8', 13:58:45 INFO - 'LANGUAGE': 'en_US:en', 13:58:45 INFO - 'LOGNAME': 'cltbld', 13:58:45 INFO - 'MAIL': '/var/mail/cltbld', 13:58:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:45 INFO - 'MOZ_NO_REMOTE': '1', 13:58:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:45 INFO - 'NO_EM_RESTART': '1', 13:58:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:58:45 INFO - 'PWD': '/builds/slave/test-pgo', 13:58:45 INFO - 'SHELL': '/bin/bash', 13:58:45 INFO - 'SHLVL': '1', 13:58:45 INFO - 'TERM': 'linux', 13:58:45 INFO - 'TMOUT': '86400', 13:58:45 INFO - 'USER': 'cltbld', 13:58:45 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1451425947.489452-506125225', 13:58:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:45 INFO - '_': '/tools/buildbot/bin/python'} 13:58:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:58:45 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 13:58:45 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 13:58:45 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 13:58:45 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 13:58:45 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 13:58:45 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 13:58:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:58:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:58:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:58:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:58:47 INFO - Installing collected packages: mozsystemmonitor 13:58:47 INFO - Running setup.py install for mozsystemmonitor 13:58:47 INFO - Successfully installed mozsystemmonitor 13:58:47 INFO - Cleaning up... 13:58:47 INFO - Return code: 0 13:58:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:58:47 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')]} 13:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:47 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')]} 13:58:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:47 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 0x7f6d96193f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc13f0>, '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 0x1d53560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d53a10>, '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': '6ef107882637bc5fc02d78b7000001c2-1451425947.489452-506125225', '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 13:58:47 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 13:58:47 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 13:58:47 INFO - Using env: {'DISPLAY': ':0', 13:58:47 INFO - 'HOME': '/home/cltbld', 13:58:47 INFO - 'LANG': 'en_US.UTF-8', 13:58:47 INFO - 'LANGUAGE': 'en_US:en', 13:58:47 INFO - 'LOGNAME': 'cltbld', 13:58:47 INFO - 'MAIL': '/var/mail/cltbld', 13:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:47 INFO - 'MOZ_NO_REMOTE': '1', 13:58:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:47 INFO - 'NO_EM_RESTART': '1', 13:58:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:58:47 INFO - 'PWD': '/builds/slave/test-pgo', 13:58:47 INFO - 'SHELL': '/bin/bash', 13:58:47 INFO - 'SHLVL': '1', 13:58:47 INFO - 'TERM': 'linux', 13:58:47 INFO - 'TMOUT': '86400', 13:58:47 INFO - 'USER': 'cltbld', 13:58:47 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1451425947.489452-506125225', 13:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:47 INFO - '_': '/tools/buildbot/bin/python'} 13:58:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:48 INFO - Downloading/unpacking blobuploader==1.2.4 13:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:49 INFO - Downloading blobuploader-1.2.4.tar.gz 13:58:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:58:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:58:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:58:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:58:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:50 INFO - Downloading docopt-0.6.1.tar.gz 13:58:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:58:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:58:50 INFO - Installing collected packages: blobuploader, requests, docopt 13:58:50 INFO - Running setup.py install for blobuploader 13:58:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:58:50 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:58:50 INFO - Running setup.py install for requests 13:58:50 INFO - Running setup.py install for docopt 13:58:51 INFO - Successfully installed blobuploader requests docopt 13:58:51 INFO - Cleaning up... 13:58:51 INFO - Return code: 0 13:58:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:58:51 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')]} 13:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:51 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')]} 13:58:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:51 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 0x7f6d96193f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc13f0>, '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 0x1d53560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d53a10>, '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': '6ef107882637bc5fc02d78b7000001c2-1451425947.489452-506125225', '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 13:58:51 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 13:58:51 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 13:58:51 INFO - Using env: {'DISPLAY': ':0', 13:58:51 INFO - 'HOME': '/home/cltbld', 13:58:51 INFO - 'LANG': 'en_US.UTF-8', 13:58:51 INFO - 'LANGUAGE': 'en_US:en', 13:58:51 INFO - 'LOGNAME': 'cltbld', 13:58:51 INFO - 'MAIL': '/var/mail/cltbld', 13:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:51 INFO - 'MOZ_NO_REMOTE': '1', 13:58:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:51 INFO - 'NO_EM_RESTART': '1', 13:58:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:58:51 INFO - 'PWD': '/builds/slave/test-pgo', 13:58:51 INFO - 'SHELL': '/bin/bash', 13:58:51 INFO - 'SHLVL': '1', 13:58:51 INFO - 'TERM': 'linux', 13:58:51 INFO - 'TMOUT': '86400', 13:58:51 INFO - 'USER': 'cltbld', 13:58:51 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1451425947.489452-506125225', 13:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:51 INFO - '_': '/tools/buildbot/bin/python'} 13:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:58:51 INFO - Running setup.py (path:/tmp/pip-gcg40S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:58:51 INFO - Running setup.py (path:/tmp/pip-Dn1ZVK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:58:51 INFO - Running setup.py (path:/tmp/pip-EUqjy0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:58:51 INFO - Running setup.py (path:/tmp/pip-bd32x9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:58:51 INFO - Running setup.py (path:/tmp/pip-I7uPVy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:58:51 INFO - Running setup.py (path:/tmp/pip-wDC_cd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:58:51 INFO - Running setup.py (path:/tmp/pip-LO8H8s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:58:51 INFO - Running setup.py (path:/tmp/pip-0VWPxP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:58:51 INFO - Running setup.py (path:/tmp/pip-WMUgUe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:58:52 INFO - Running setup.py (path:/tmp/pip-67VHGX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:58:52 INFO - Running setup.py (path:/tmp/pip-_u4sJ4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:58:52 INFO - Running setup.py (path:/tmp/pip-Z0HXKE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:58:52 INFO - Running setup.py (path:/tmp/pip-atpfix-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:58:52 INFO - Running setup.py (path:/tmp/pip-nMglX5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:58:52 INFO - Running setup.py (path:/tmp/pip-DWkpof-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:58:52 INFO - Running setup.py (path:/tmp/pip-7OgDnu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:58:52 INFO - Running setup.py (path:/tmp/pip-iCQ7v2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:58:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:58:52 INFO - Running setup.py install for manifestparser 13:58:52 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:58:52 INFO - Running setup.py install for mozcrash 13:58:52 INFO - Running setup.py install for mozdebug 13:58:52 INFO - Running setup.py install for mozdevice 13:58:53 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:58:53 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:58:53 INFO - Running setup.py install for mozfile 13:58:53 INFO - Running setup.py install for mozhttpd 13:58:53 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:58:53 INFO - Running setup.py install for mozinfo 13:58:53 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:58:53 INFO - Running setup.py install for mozInstall 13:58:53 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:58:53 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:58:53 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:58:53 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:58:53 INFO - Running setup.py install for mozleak 13:58:53 INFO - Running setup.py install for mozlog 13:58:53 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:58:53 INFO - Running setup.py install for moznetwork 13:58:53 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:58:53 INFO - Running setup.py install for mozprocess 13:58:53 INFO - Running setup.py install for mozprofile 13:58:53 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:58:53 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:58:53 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:58:53 INFO - Running setup.py install for mozrunner 13:58:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:58:54 INFO - Running setup.py install for mozscreenshot 13:58:54 INFO - Running setup.py install for moztest 13:58:54 INFO - Running setup.py install for mozversion 13:58:54 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:58:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:58:54 INFO - Cleaning up... 13:58:54 INFO - Return code: 0 13:58:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:58:54 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')]} 13:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:54 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')]} 13:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:54 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 0x7f6d96193f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc13f0>, '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 0x1d53560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d53a10>, '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': '6ef107882637bc5fc02d78b7000001c2-1451425947.489452-506125225', '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 13:58:54 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 13:58:54 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 13:58:54 INFO - Using env: {'DISPLAY': ':0', 13:58:54 INFO - 'HOME': '/home/cltbld', 13:58:54 INFO - 'LANG': 'en_US.UTF-8', 13:58:54 INFO - 'LANGUAGE': 'en_US:en', 13:58:54 INFO - 'LOGNAME': 'cltbld', 13:58:54 INFO - 'MAIL': '/var/mail/cltbld', 13:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:54 INFO - 'MOZ_NO_REMOTE': '1', 13:58:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:54 INFO - 'NO_EM_RESTART': '1', 13:58:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:58:54 INFO - 'PWD': '/builds/slave/test-pgo', 13:58:54 INFO - 'SHELL': '/bin/bash', 13:58:54 INFO - 'SHLVL': '1', 13:58:54 INFO - 'TERM': 'linux', 13:58:54 INFO - 'TMOUT': '86400', 13:58:54 INFO - 'USER': 'cltbld', 13:58:54 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1451425947.489452-506125225', 13:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:54 INFO - '_': '/tools/buildbot/bin/python'} 13:58:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:58:54 INFO - Running setup.py (path:/tmp/pip-H2hC1a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:58:54 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)) 13:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:58:54 INFO - Running setup.py (path:/tmp/pip-6bwsHe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:58:54 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)) 13:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:58:54 INFO - Running setup.py (path:/tmp/pip-vaEIgY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:58:54 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)) 13:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:58:54 INFO - Running setup.py (path:/tmp/pip-1HU4Ia-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:58:54 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)) 13:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:58:54 INFO - Running setup.py (path:/tmp/pip-fWKKR3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:58:54 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)) 13:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:58:54 INFO - Running setup.py (path:/tmp/pip-lkKQP6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:58:55 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)) 13:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:58:55 INFO - Running setup.py (path:/tmp/pip-pnpda4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:58:55 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)) 13:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:58:55 INFO - Running setup.py (path:/tmp/pip-RZ72Jz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:58:55 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)) 13:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:58:55 INFO - Running setup.py (path:/tmp/pip-CPMm7Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:58:55 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)) 13:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:58:55 INFO - Running setup.py (path:/tmp/pip-SXJ7Bn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:58:55 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)) 13:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:58:55 INFO - Running setup.py (path:/tmp/pip-g_Jj_2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:58:55 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)) 13:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:58:55 INFO - Running setup.py (path:/tmp/pip-JfVJbg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:58:55 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)) 13:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:58:55 INFO - Running setup.py (path:/tmp/pip-bG4JL8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:58:55 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)) 13:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:58:55 INFO - Running setup.py (path:/tmp/pip-Op4GtZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:58:55 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)) 13:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:58:55 INFO - Running setup.py (path:/tmp/pip-xEdFee-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:58:55 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)) 13:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:58:55 INFO - Running setup.py (path:/tmp/pip-iuB4mO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:58:55 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)) 13:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:58:55 INFO - Running setup.py (path:/tmp/pip-drr2Mi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:58:55 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)) 13:58:55 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)) 13:58:55 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)) 13:58:55 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)) 13:58:55 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)) 13:58:55 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)) 13:58:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:58:55 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 13:58:55 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 13:58:55 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 13:58:55 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 13:58:55 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 13:58:55 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 13:58:57 INFO - Downloading blessings-1.5.1.tar.gz 13:58:57 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 13:58:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:58:57 INFO - Installing collected packages: blessings 13:58:57 INFO - Running setup.py install for blessings 13:58:57 INFO - Successfully installed blessings 13:58:57 INFO - Cleaning up... 13:58:58 INFO - Return code: 0 13:58:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:58:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:58:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:58:58 INFO - Reading from file tmpfile_stdout 13:58:58 INFO - Current package versions: 13:58:58 INFO - argparse == 1.2.1 13:58:58 INFO - blessings == 1.5.1 13:58:58 INFO - blobuploader == 1.2.4 13:58:58 INFO - docopt == 0.6.1 13:58:58 INFO - manifestparser == 1.1 13:58:58 INFO - mozInstall == 1.12 13:58:58 INFO - mozcrash == 0.16 13:58:58 INFO - mozdebug == 0.1 13:58:58 INFO - mozdevice == 0.47 13:58:58 INFO - mozfile == 1.2 13:58:58 INFO - mozhttpd == 0.7 13:58:58 INFO - mozinfo == 0.9 13:58:58 INFO - mozleak == 0.1 13:58:58 INFO - mozlog == 3.1 13:58:58 INFO - moznetwork == 0.27 13:58:58 INFO - mozprocess == 0.22 13:58:58 INFO - mozprofile == 0.28 13:58:58 INFO - mozrunner == 6.11 13:58:58 INFO - mozscreenshot == 0.1 13:58:58 INFO - mozsystemmonitor == 0.0 13:58:58 INFO - moztest == 0.7 13:58:58 INFO - mozversion == 1.4 13:58:58 INFO - psutil == 3.1.1 13:58:58 INFO - requests == 1.2.3 13:58:58 INFO - wsgiref == 0.1.2 13:58:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f6d96193f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc13f0>, '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 0x1d53560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d53a10>, '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': '6ef107882637bc5fc02d78b7000001c2-1451425947.489452-506125225', '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 13:58:58 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 13:58:58 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 13:58:58 INFO - Using env: {'DISPLAY': ':0', 13:58:58 INFO - 'HOME': '/home/cltbld', 13:58:58 INFO - 'LANG': 'en_US.UTF-8', 13:58:58 INFO - 'LANGUAGE': 'en_US:en', 13:58:58 INFO - 'LOGNAME': 'cltbld', 13:58:58 INFO - 'MAIL': '/var/mail/cltbld', 13:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:58 INFO - 'MOZ_NO_REMOTE': '1', 13:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:58 INFO - 'NO_EM_RESTART': '1', 13:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:58:58 INFO - 'PWD': '/builds/slave/test-pgo', 13:58:58 INFO - 'SHELL': '/bin/bash', 13:58:58 INFO - 'SHLVL': '1', 13:58:58 INFO - 'TERM': 'linux', 13:58:58 INFO - 'TMOUT': '86400', 13:58:58 INFO - 'USER': 'cltbld', 13:58:58 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1451425947.489452-506125225', 13:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:58 INFO - '_': '/tools/buildbot/bin/python'} 13:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:58 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)) 13:58:58 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)) 13:58:58 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)) 13:58:58 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)) 13:58:58 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)) 13:58:58 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)) 13:58:58 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)) 13:58:58 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)) 13:58:58 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)) 13:58:58 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)) 13:58:58 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)) 13:58:58 INFO - Cleaning up... 13:58:58 INFO - Return code: 0 13:58:58 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6d96193f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc13f0>, '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 0x1d53560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d53a10>, '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': '6ef107882637bc5fc02d78b7000001c2-1451425947.489452-506125225', '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 13:58:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 13:58:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:58:58 INFO - Using env: {'DISPLAY': ':0', 13:58:58 INFO - 'HOME': '/home/cltbld', 13:58:58 INFO - 'LANG': 'en_US.UTF-8', 13:58:58 INFO - 'LANGUAGE': 'en_US:en', 13:58:58 INFO - 'LOGNAME': 'cltbld', 13:58:58 INFO - 'MAIL': '/var/mail/cltbld', 13:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:58 INFO - 'MOZ_NO_REMOTE': '1', 13:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:58 INFO - 'NO_EM_RESTART': '1', 13:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:58:58 INFO - 'PWD': '/builds/slave/test-pgo', 13:58:58 INFO - 'SHELL': '/bin/bash', 13:58:58 INFO - 'SHLVL': '1', 13:58:58 INFO - 'TERM': 'linux', 13:58:58 INFO - 'TMOUT': '86400', 13:58:58 INFO - 'USER': 'cltbld', 13:58:58 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1451425947.489452-506125225', 13:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:58 INFO - '_': '/tools/buildbot/bin/python'} 13:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:58 INFO - Downloading/unpacking jsonschema 13:58: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 13:58: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 13:58: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 13:58: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 13:58: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 13:58: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 13:59:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:59:00 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 13:59:00 INFO - Downloading/unpacking functools32 (from jsonschema) 13:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:00 INFO - Downloading functools32-3.2.3-2.tar.gz 13:59:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:59:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:59:00 INFO - warning: no files found matching '*.txt' 13:59:00 INFO - no previously-included directories found matching 'build' 13:59:00 INFO - no previously-included directories found matching 'dist' 13:59:00 INFO - no previously-included directories found matching '.git*' 13:59:00 INFO - Installing collected packages: jsonschema, functools32 13:59:00 INFO - Running setup.py install for functools32 13:59:00 INFO - warning: no files found matching '*.txt' 13:59:00 INFO - no previously-included directories found matching 'build' 13:59:00 INFO - no previously-included directories found matching 'dist' 13:59:00 INFO - no previously-included directories found matching '.git*' 13:59:00 INFO - Successfully installed jsonschema functools32 13:59:00 INFO - Cleaning up... 13:59:00 INFO - Return code: 0 13:59:00 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6d96193f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc13f0>, '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 0x1d53560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d53a10>, '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': '6ef107882637bc5fc02d78b7000001c2-1451425947.489452-506125225', '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 13:59:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 13:59:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:59:00 INFO - Using env: {'DISPLAY': ':0', 13:59:00 INFO - 'HOME': '/home/cltbld', 13:59:00 INFO - 'LANG': 'en_US.UTF-8', 13:59:00 INFO - 'LANGUAGE': 'en_US:en', 13:59:00 INFO - 'LOGNAME': 'cltbld', 13:59:00 INFO - 'MAIL': '/var/mail/cltbld', 13:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:00 INFO - 'MOZ_NO_REMOTE': '1', 13:59:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:00 INFO - 'NO_EM_RESTART': '1', 13:59:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:59:00 INFO - 'PWD': '/builds/slave/test-pgo', 13:59:00 INFO - 'SHELL': '/bin/bash', 13:59:00 INFO - 'SHLVL': '1', 13:59:00 INFO - 'TERM': 'linux', 13:59:00 INFO - 'TMOUT': '86400', 13:59:00 INFO - 'USER': 'cltbld', 13:59:00 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1451425947.489452-506125225', 13:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:00 INFO - '_': '/tools/buildbot/bin/python'} 13:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:01 INFO - Downloading/unpacking flake8 13:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:59:02 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 13:59:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:59:02 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 13:59:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:03 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 13:59:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:59:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:59:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:59:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:59:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:59:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:59:03 INFO - no previously-included directories found matching 'docs/_build' 13:59:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:59:03 INFO - Running setup.py install for pep8 13:59:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:59:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:59:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:59:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:59:03 INFO - no previously-included directories found matching 'docs/_build' 13:59:03 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:59:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:59:03 INFO - Cleaning up... 13:59:03 INFO - Return code: 0 13:59:03 INFO - Running post-action listener: _resource_record_post_action 13:59:03 INFO - Running post-action listener: _start_resource_monitoring 13:59:03 INFO - Starting resource monitoring. 13:59:03 INFO - ##### 13:59:03 INFO - ##### Running install step. 13:59:03 INFO - ##### 13:59:03 INFO - Running pre-action listener: _resource_record_pre_action 13:59:03 INFO - Running main action method: install 13:59:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:59:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:59:03 INFO - Reading from file tmpfile_stdout 13:59:03 INFO - Detecting whether we're running mozinstall >=1.0... 13:59:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:59:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:59:03 INFO - Reading from file tmpfile_stdout 13:59:03 INFO - Output received: 13:59:03 INFO - Usage: mozinstall [options] installer 13:59:03 INFO - Options: 13:59:03 INFO - -h, --help show this help message and exit 13:59:03 INFO - -d DEST, --destination=DEST 13:59:03 INFO - Directory to install application into. [default: 13:59:03 INFO - "/builds/slave/test-pgo"] 13:59:03 INFO - --app=APP Application being installed. [default: firefox] 13:59:03 INFO - mkdir: /builds/slave/test-pgo/build/application 13:59:03 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'] 13:59:03 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 13:59:19 INFO - Reading from file tmpfile_stdout 13:59:19 INFO - Output received: 13:59:19 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:59:19 INFO - Running post-action listener: _resource_record_post_action 13:59:19 INFO - ##### 13:59:19 INFO - ##### Running run-tests step. 13:59:19 INFO - ##### 13:59:19 INFO - Running pre-action listener: _resource_record_pre_action 13:59:19 INFO - Running main action method: run_tests 13:59:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:59:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:59:19 INFO - Python 2.7.3 13:59:19 INFO - Return code: 0 13:59:19 INFO - grabbing minidump binary from tooltool 13:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:19 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 0x1cc13f0>, '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 0x1d53560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d53a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:59:19 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 13:59:19 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 13:59:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:59:19 INFO - Return code: 0 13:59:19 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:59:19 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:59:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:59:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:59:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:59:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:59:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:59:20 INFO - Return code: 0 13:59:20 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/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 13:59:20 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/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 13:59:20 INFO - Using env: {'DISPLAY': ':0', 13:59:20 INFO - 'HOME': '/home/cltbld', 13:59:20 INFO - 'LANG': 'en_US.UTF-8', 13:59:20 INFO - 'LANGUAGE': 'en_US:en', 13:59:20 INFO - 'LOGNAME': 'cltbld', 13:59:20 INFO - 'MAIL': '/var/mail/cltbld', 13:59:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:59:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:59:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:20 INFO - 'MOZ_NO_REMOTE': '1', 13:59:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:59:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:20 INFO - 'NO_EM_RESTART': '1', 13:59:20 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:59:20 INFO - 'PWD': '/builds/slave/test-pgo', 13:59:20 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:59:20 INFO - 'SHELL': '/bin/bash', 13:59:20 INFO - 'SHLVL': '1', 13:59:20 INFO - 'TERM': 'linux', 13:59:20 INFO - 'TMOUT': '86400', 13:59:20 INFO - 'USER': 'cltbld', 13:59:20 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1451425947.489452-506125225', 13:59:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:20 INFO - '_': '/tools/buildbot/bin/python'} 13:59:20 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/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 13:59:20 INFO - mozversion application_buildid: 20151229113008 13:59:20 INFO - mozversion application_changeset: 7d1b18c49d6599ec982477034e86c721ff7cff23 13:59:20 INFO - mozversion application_display_name: Nightly 13:59:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:59:20 INFO - mozversion application_name: Firefox 13:59:20 INFO - mozversion application_remotingname: firefox 13:59:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:59:20 INFO - mozversion application_vendor: Mozilla 13:59:20 INFO - mozversion application_version: 46.0a1 13:59:20 INFO - mozversion platform_buildid: 20151229113008 13:59:20 INFO - mozversion platform_changeset: 7d1b18c49d6599ec982477034e86c721ff7cff23 13:59:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:59:20 INFO - mozversion platform_version: 46.0a1 13:59:20 INFO - using testdate: 1451426360 13:59:20 INFO - actual date: 1451426360 13:59:20 INFO - starting webserver on 'localhost:34368' 13:59:20 INFO - SUITE-START | Running 3 tests 13:59:20 INFO - TEST-START | dromaeo_css 13:59:20 INFO - operating with platform_type : linux_ 13:59:20 INFO - Initialising browser for dromaeo_css test... 13:59:20 INFO - TEST-INFO | started process 5237 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmploeh2S/profile http://localhost:34368/getInfo.html) 13:59:25 INFO - PROCESS | 5237 | __metrics Screen width/height:1600/1200 13:59:25 INFO - PROCESS | 5237 | colorDepth:24 13:59:25 INFO - PROCESS | 5237 | Browser inner width/height: 1024/697 13:59:25 INFO - PROCESS | 5237 | __metrics 13:59:25 INFO - PROCESS | 5237 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:59:26 INFO - TEST-INFO | 5237: exit 0 13:59:26 INFO - Browser initialized. 13:59:26 INFO - Running cycle 1/1 for dromaeo_css test... 13:59:26 INFO - TEST-INFO | started process 5372 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmploeh2S/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:59:38 INFO - PROCESS | 5372 | RSS: Main: 149454848 13:59:38 INFO - PROCESS | 5372 | 14:00:28 INFO - PROCESS | 5372 | 1451426428280 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] 14:02:36 INFO - PROCESS | 5372 | Cycle 1(1): loaded http://localhost:34368/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34368/tests/dromaeo/cssquery-ext.html) 14:02:38 INFO - PROCESS | 5372 | RSS: Main: 159019008 14:02:38 INFO - PROCESS | 5372 | 14:05:40 INFO - PROCESS | 5372 | Cycle 1(1): loaded http://localhost:34368/tests/dromaeo/cssquery-ext.html (next: http://localhost:34368/tests/dromaeo/cssquery-jquery.html) 14:05:40 INFO - PROCESS | 5372 | RSS: Main: 154255360 14:05:40 INFO - PROCESS | 5372 | 14:08:42 INFO - PROCESS | 5372 | Cycle 1(1): loaded http://localhost:34368/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34368/tests/dromaeo/cssquery-mootools.html) 14:08:43 INFO - PROCESS | 5372 | RSS: Main: 153153536 14:08:43 INFO - PROCESS | 5372 | 14:11:44 INFO - PROCESS | 5372 | Cycle 1(1): loaded http://localhost:34368/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34368/tests/dromaeo/cssquery-prototype.html) 14:11:45 INFO - PROCESS | 5372 | RSS: Main: 152150016 14:11:45 INFO - PROCESS | 5372 | 14:14:47 INFO - PROCESS | 5372 | Cycle 1(1): loaded http://localhost:34368/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34368/tests/dromaeo/cssquery-yui.html) 14:14:48 INFO - PROCESS | 5372 | RSS: Main: 152121344 14:14:48 INFO - PROCESS | 5372 | 14:17:50 INFO - PROCESS | 5372 | Cycle 1(1): loaded http://localhost:34368/tests/dromaeo/cssquery-yui.html (next: http://localhost:34368/tests/dromaeo/cssquery-dojo.html) 14:17:51 INFO - PROCESS | 5372 | RSS: Main: 154812416 14:17:51 INFO - PROCESS | 5372 | 14:17:51 INFO - PROCESS | 5372 | __start_tp_report 14:17:51 INFO - PROCESS | 5372 | _x_x_mozilla_page_load 14:17:51 INFO - PROCESS | 5372 | _x_x_mozilla_page_load_details 14:17:51 INFO - PROCESS | 5372 | |i|pagename|runs| 14:17:51 INFO - PROCESS | 5372 | |0;dojo.html;3169.4770362890126;3228.2413632796274;3259.1852036990754;3267.8039317640937;3277.082416923261;5206.245094461301;5326.467353264671;5359.946400535993;5360.035193665134;5369.060414427474;5190.013897359499;5234.293370394996;5276.736163191844;5281.947180528203;5317.867053323669;4480.417545719052;4762.857114286577;4910.75446227689;4920.778564964585;4922.80308787648;4754.85735427936;4840.9757951210195;4898.167311557026;4909.091818013679;4934.037862616791;4793.616510679138;4808.110499557575;4842.225243960949;4895.853124406238;4943.555080042777;4850.175470170079;4856.587190088847;4881.633877459205;4884.438289596671;4904.656674032819;4688.156131896258;4811.422629284473;4824.7828847701585;4841.15279826029;4847.151748444008;5066.898662026776;5090.516400941905;5139.100657384943;5146.176611742103;5181.5854731621375;5720.342160651495;5722.513586345166;5726.513246374063;5727.455891690282;5734.512566431817;5605.943940560583;5740.425957404268;5763.740631671543;5764.250647415851;5766.274976449023;5343.118385466393;5412.675239485604;5412.810551630674;5432.212329212242;5432.75552600134;5851.502622277069;5897;5900.616459930091;5909.025010873243;5919.260092488439;5529.889402211933;5643.984082865124;5651.350094739076;5663.886722265532;5677.772889084473;5663.263775709132;5664.291963504562;5664.660120392789;5699.088145896637;5714.514266287412;5585.832425027255;5631.211630371751;5636.633618814764;5649.096144616841;5661.150827375926;5608.46719561641;5615.494605485526;5623.072193088176;5636.436356364331;5668.943310566841;4416.867493975186;4436.778161091933;4458.643308535309;4462.062966776948;4500.729956202638;3903.4535165076913;3916.7845768483007;3936.9212615747524;3940.0346915006007;3973.0861901762755;5229.816956406507;5318.12250978592;5344.331958505187;5397.622166448311;5414.160805075219;5722.399148089391;5745.741441635137;5748.48263656273;5762.827115186551;5771.9711401443565;5387.595930305243;5398.541124004425;5399.163129714901;5400.91898621521;5408.972955135199;4882.926756098661;4943.505649435027;4952.430470495867;4972.7513624318635;5036.949630503648;5933.910991335133;5952.583319167703;5953.642781433128;5960.314563825215;5966;5715.485606295453;5729.770809167587;5743.569232307677;5745.195672605755;5748.540116790563;5728.713564321851;5808.186853840381;5857.062869940789;5933.317668468008;5942.405759424023;5631.662100273997;5644.915326270191;5649.68926709035;5650.689212093374;5653.349864765604;5547.750351234124;5698.6580805151825;5708.429157084258;5762;5762.4525670061275;5477.917831232615;5557.666540007613;5558.305211848519;5562.694051827189;5597.384287728265;5508.779648814003;5510.063289240758;5511.173324001272;5528.834134975958;5533.889322213614;5332.520073193431;5458.372287187024;5483.287172667528;5487.6158668892795;5533.7786488540005;5488;5541.224228608079;5563.082091454865;5570.969370666439;5576.944230557642;5364.8122315718765;5441.782328706808;5454.372747133972;5455.509004189642;5488.231647569263 14:17:51 INFO - PROCESS | 5372 | |1;ext.html;512.2188662290007;545.3564793543618;549.1488193300384;553.5765139668152;553.8338498450464;34304.82847585762;35251.82374088132;35266.8236658817;35369.64630353696;35391.2921741565;40311;40846.59153408465;40892.59107408925;40977.59022409775;41182;8672.653093876253;8907.77730556738;8912.197902188802;8912.8663070054;8913.153250441197;8540.957295213515;8720.651173953034;8779.95610021949;8784.341174411913;8788;8784.736457906272;8879.467231966071;8903.37676362655;8909.242714369286;8915.465072095694;8718.302535797122;8800.427972181787;8810.955945220298;8827.646894124227;8831.823363532694;8644.48133112009;8730.563471826383;8731.650733970633;8769.736907892773;8796.604152813139;38333;38476.42285365722;38746.80626596877;38750.612493874985;38818.80590597057;3249.723773479257;3250.6424293327714;3251.219707270238;3251.9349613007607;3262;29134;29313.853430732925;29383.70616293831;29645.70354296451;29848.104556863327;3496.0735405117666;3500.7701098027323;3513.4905438711244;3579.427291633352;3617.7829330240006;249851;249930;251445;252040;252164;49362;50352.74823625859;55115.724421378436;55404.78380864801;55661.721691391285;60145.398546014854;61286.69356653188;61356;61976.38023619796;62020.689896550226;13612.863871361358;13770.173789572658;13776.586702398945;13778.586642400744;13783.173009619455;10101.898981010243;10201.336913100773;10244.334118282288;10270.691879243635;10324.277300589038;18033.54916127081;18145.546361341072;18229.54426139357;18233.27066917335;18971.33600323982;7516.586587737617;7551.244875512514;7716.189800071024;7771.378289736807;7799.571023593757;967.086103632075;980.4362491567377;1021.4994652620163;1077.5258886090253;1111.1166622535104;28887.42225155485;32039.839800800848;32048.839755801073;32098.83950580232;32216.19459513531;1072.3244356055634;1086.125668836594;1094.5567045346647;1129;1154.3824054131;14396.784048239284;14607.19660418687;14631.92684036573;14862.628434289012;14909.25453727331;319980;321267;324029;324699;325166;50540.49459505431;50758.492415076114;50837;51098.74450627723;51295.7435212829;1310.4954592481772;1328.7408955253634;1338.4913732781674;1338.9999999999804;1340.222670850904;27724.72275277302;28277.71722282833;28368.85815570909;28401.57397638996;28677.85661071681;45317.54682453133;45815.625531234116;45884.31173532466;45915.08169836651;45926.55550833634;303366;305174;305384;305809;305823;30521.100495452898;31068;31392;31865.6813431872;32120.839395802872;41277.587224127376;41377.37933930933;41729.79135104427;42225.36661950134;42400;34428.31143377069;35071.824640876635;35233.471497927036;35298.82350588333;35760.28479430345;34742.47886281657;34888.65111348854;35074.29851403009;35336;35411.114722131126;31638.367232655677;31990.68009319877;32019.199520011254;32139.35721285608;35752.46371304485;27784.19026765671;29893;32075;32161.839190804832;32223.194420139684;24246.26943962957;24811.25566233016;25099.74900250974;25111.623325649765;25301.493970120864 14:17:51 INFO - PROCESS | 5372 | |2;jquery.html;351.7555299067149;352.59099444644215;354.72508805675614;356.82693893461675;357.15176455917197;16227.26977286022;16408.671826563463;17038.403655872047;17203.655926881456;17844.28622855084;13982;14106.224157671324;14109.858901410982;14118.08232464889;14367.856321436808;4482.529334419888;4753.482423006976;5014.247862820588;5058.949410505885;5073.543381095701;4960.801567937278;4968.453470118284;4972.129877271481;4980.2529620557025;4982.800687972495;4859.975700121495;4953.752312384367;5049.4698056704065;5177.559907407875;5197.740112994354;4321.330193819963;5143.408508021588;5183.81856635016;5230.189320655286;5623.493885550321;5226.608004399685;5237.266782650432;5263.526282634543;5265.552428043621;5267.394249661262;12636.431360588796;12739.490420383174;20032.79967200324;20498.18007279707;20584.27955021582;2086.9165233390645;2089.7596776370606;2155.482684155807;2180.258712037899;2244.1584405847807;9505.287103467199;9803.362781419257;9868.90131098687;11835.585754498552;12591.622251332476;1726.180064469367;1793.2289115680253;1827.4974382044911;1841.8250266224686;1883.0584707646176;57937.13094303589;60439.395606043814;60775.696121519555;61879.07181392283;62818.68590657017;9979.151772099453;10155.187584993182;10235.744106397251;10267.229957753198;10289.53697083633;13478.921686265272;13506.527271545448;13509.392077356346;13510.594682159552;13533.120347177599;7123.180834204029;7184.066071410683;7190.424766018706;7222.33886206165;7230.132384113835;6636.336366363325;6710.396064354134;6727.159105111861;6745.628990405575;6746.662666866735;4330.848420305274;4384.298512238091;4384.736915784999;4454.042380888124;4484.327350897326;1723.526030341641;1778.2531336838301;1850.9352172673891;1855.4804654696707;1870.345379117298;831.8876951611576;886.499127992682;985.2069084386994;1025.323286630835;1026.14829691356;16459.83540164607;16471.83528164703;16659.25033373501;16695.91652041732;16808.57978550546;908.1871724806393;909.1090731083575;917.5228880981851;967.2310513142069;984.478226539935;9459;9609.51952402391;9627.133557979816;9658.855117173249;9883.11052005323;536284;548235;552149;558983;561717;45141.09717805691;77781;78591.60704196557;79883;80868.59565702133;1068.6847380023066;1078.0890147825075;1092.8415379769888;1109.805783987815;1115.9721006974892;14777.408903643734;14941.701165976403;15166.165860877758;15182.392704291704;15383;32350.029499115066;32564.674353256163;33979.15052123618;35684.28631427409;37121.443178352885;43260.35109473298;43451.130977380904;43896;44454.77772611116;45745.77127114476;9189.908100918905;9338.813223735351;9445.338826282094;9531.285153613646;9581.329306948446;11318.660440186808;11445.599404020819;11511.712207194887;14079.507217247758;17559.561010974317;12531.49874005066;13984.860151398356;14389.208593527457;14749.410023598935;14807.925960370128;14120.78818817698;14210.78683819723;14366.13803171813;14394.568162955127;14845.183514906352;14446.638834029234;14595.781063284272;14630.122192668474;14749.483768068067;14760.778588320969;9341.392809467363;9434.81130377375;9437.81124377495;9610.375325603813;9612.279079068958;10158;10200.540975655966;12775.425105870072;13981.720365592428;14196.929015354857 14:17:51 INFO - PROCESS | 5372 | |3;mootools.html;1399.517166577531;1415.964600884978;1515.3711209847913;1686.671099135669;1700.183911722374;6753.594784312944;6803.557768745034;6835.077264569275;6898.689558969846;6913.204981427138;6924.272951340113;6943.409810166142;7006.124234470692;7012.123484564429;7012.929870701291;2138.8182004529635;2163.3834357208198;2165.317924853674;2169.566086782642;2176.336217453676;2140.1011575138477;2178.7276590426195;2188.321620297705;2189.1462329691353;2194.2320187934174;2105.231590469483;2126.447123747821;2152.1283880028614;2156.6010288096754;2164.5779073080757;2143.3677065265783;2176.227439259064;2199.230269405711;2206.746224184223;2218.1238410827714;2173.4892300309416;2174.847760656755;2197.7362716473967;2198.6372248578964;2201.4276288165192;6819.829504262433;6964.756233531853;6971.442284617218;6976.162860456727;6981.685824137875;4157.0023194433425;4225.133847561243;4233.7883105844585;4256.36154576816;4261.87214383569;2765.4883846488265;2829.4906916754976;2843.772498200139;2849.145256423065;2863.9427211455863;936.3539157980971;940.2149205413488;941.4915945389481;954.2652157838426;974.8391515399951;8659.26396256319;8778.780530486725;8828.117188281185;8839.867401988975;8931.598078086501;3746.194568167857;3750.6624403803244;3847.961520384816;3850.0567360996733;3872.7676339419727;7867.173946735625;7869.606519673994;7881.0936742274225;7914.881276780853;7922.247386498273;4141.378793181047;4172.7704976226;4224.809883555247;4272.807723652443;4272.850450234227;3911.041794760302;3912.8239229234755;3920.3335432976464;3921.3725803871243;3958.8416463341146;3270.705636492727;3272.4109660260906;3319.1204330852343;3356.278400143981;3360.1599600099976;1062.3148069495132;1066.8773091094624;1081.0810810810906;1094.6114129484079;1101.0805977009127;1012.9949350253202;1017;1116.3692513729716;1163.139276935079;1266.7339858629607;6358.77744278948;6365.745370185234;6419.839504012343;6441.3880681335195;6446.838829029218;1091.770728147098;1100.312304809494;1128.6049882541045;1131.6646357298466;1141.594733869481;4868.02639472107;4915.852524424273;5036.471170527042;5235.973820130875;5236.581073514109;7789.883151752615;7930.841383172419;7970.800729981797;8153.103158652543;8188.058373287029;7910.446268761247;7988.360931125496;8008.199180081945;8068.636911339004;8169.836603267901;6541.28045914949;6578.473722102125;6594.07682924391;6599.901001484982;6649.534532582673;6228;6234.37656234391;6311.147995020613;6331.588446750947;6368.745250189941;7286.6720997556295;7308.744193953186;7378.372838308589;7394.667239974322;7405.703771849066;7680.884786728316;7694.038245219348;7713.537187768752;7743.4966727162555;7770.417218708732;5728.971355143198;5871.970640146772;5872.471477567039;5876.706164691663;5901.734421951109;6321.33625969285;6372.6495042773095;6386.074019267087;6391.265004524354;6399.776007839703;5963.522918166623;6049.727762250797;6068.059450785136;6147.969260153671;6177.876442471035;6075.2405949256345;6092.817215483543;6095.329513753572;6197.504199664107;6222.937770622417;6142.754289828536;6161.44546990773;6165.630062196283;6169.383061693795;6180.042093475518;5748.48263656273;5766.5675074368755;5789.131630255327;5794.667226538004;5807.216025836627;5762.337331206797;5886.028805247258;5908.172855800105;5924;5925.377835327401 14:17:51 INFO - PROCESS | 5372 | |4;prototype.html;335.17379659140215;335.66768898790195;340.3822062955734;341.41106591130296;349.27873940313253;6309;6327.873442531147;6337.936620633793;6396.296407395189;6422.775202867901;6215.782447614334;6256.436920677138;6312.431881130698;6313.810585682425;6359.20509936258;4755;4771.403574553172;4779.784909679072;4782.234842425212;4787.449443314029;4745.952540474603;4751.287306903975;4788.353572267752;4794.089123066607;4795.664303498756;4597.632189424855;4713.245880659095;4717.457492388385;4735.266033764755;4746.572808447239;4731.929021064687;4747.786349614258;4754.334393184957;4760.238361862085;4765.404324459442;4135.738599727082;4144.274751918432;4151.294279972381;4156.9792151039355;4166.979165104185;6024.909626355608;6046.727897244635;6050.69746512677;6057.666828324441;6073.089036644495;5497.8075767348355;5576.940381327535;5587.608867379285;5591.30108736408;5598.664080155204;6692.59844409337;6694.430973367221;6710.698018589175;6712.597244165366;6722.260551339349;4600.125976064537;4613.63090952723;4620.145273124483;4630.0508395779125;4636.976815115937;6849.760258390932;7004.579725216452;7024.964875175642;7036;7043.119610048744;4630.490646028934;4637.1421287062;4648.395708557933;4649.535046495391;4652.185867473178;4695.107929493453;4707.129181101507;4710.52894710533;4711.246200607955;4714.198586240347;5477.534409575231;5488.725563721798;5506.146547285097;5512.145617429224;5515.117581186991;6494.707738151795;6650.20197576294;6658.90128128863;6674.032265321501;6740.865182696417;1648.1017845274355;1656.892302000366;1689.9662006759795;1690.8055573609192;1692;1068.5885933915342;1120.6357933671588;1132.326265871805;1137.3403426012892;1143.7655280667443;6222.315545290015;6332.208473940757;6347.619142851351;6355.809325720235;6366.522510811707;6902.930970690229;6915.654217289115;6919.100516932867;6920.826979325557;6926.757563485254;6260.40526150015;6291.559590828598;6333.746650134035;6338.144350512714;6361.554691171574;3771.41543060826;3792.6586607205486;3799.2021675448464;3802.6957843372466;3844.5386553613184;7351.558906465629;7352.448566357544;7354.080739907512;7356.301151390609;7356.816079597946;7045.647717614099;7188.281171882874;7197.1363436387965;7204.423646108299;7221.350078492961;7258.0927384076995;7277.417806575461;7306.671199796022;7308.5614863108385;7320.084989376328;7059.446921677223;7061.894071589033;7065.682044307916;7067.611281379368;7076.221615622175;6776.186857577122;6922.688479018557;6952.791416257521;6985.406240469617;6990.23107458169;7289.708411663474;7299.124105107208;7304.342609165201;7311.195768465358;7324.377427918686;4616.538346165491;4638.953610463987;4647.9767601161775;4651.86044418668;4657.46439159501;6869.896951545631;6870.793876183722;6959.408450281783;7071.398931090915;7083.787486375417;6783.728650853911;6789.456843452611;6825.761098361533;6833.282505337067;6883.827904302432;6769.796906092825;6785.219699734594;6829.180498340231;6836.179658441019;6841.350071743176;6603.80188594343;6654.334566543307;6686.398224159849;6730.528862979741;6739.427148692416;6844.657767111724;6884.483663725341;6885.242623311332;6888.311168883272;6890.827729306808;6582.0785090086465;6613.14029176204;6620.139381880517;6623;6658.7336506539195 14:17:51 INFO - PROCESS | 5372 | |5;yui.html;792.342355844649;798.3453568074182;825.1500954017363;857.794129408942;869.8999615044272;13034.73930521389;13275.867241327584;13276.402561884726;13368.131071480348;13388.531401400953;13014.609561713163;13070.346482675852;13099.083064185486;13105.934470327635;13118.868811311884;814.9633266503007;818.2431251092745;832.9875051874227;834.6953362022879;839.6473481137906;820.4707963363627;822.1408627983772;822.3256929317962;827.6565225431439;829.1998221716043;869.1308691308691;873.3057219510473;873.3973558244822;873.6112429968666;873.6549063120063;869.9347548933823;871.8299931513326;872.4547158026234;873.7160422862531;874.9956250218772;640.0910706796313;642.1940464716797;643.488426700774;643.7296335539085;645.2611759535353;14052.437902483889;14143.575692729235;14148.080374775607;14160.291985400792;14168.220747858864;12222.694432639166;12244.571439999558;12426.875731242662;12454.501819927282;12813;10169.745756356151;10364.585416583328;10364.844527332096;10365.170786337076;10716.035556799925;3564.6435356464144;3635.314770517644;3640.9271814563826;3769.321522126016;3791.3554695701796;46649.53350466486;47026.5297347029;47202.52797472016;47534;47612.52387476116;10203.132733717717;10223.693289201336;10228.64199753005;10343.327683700536;10404.479776011169;18608.16263268129;18897.811021889604;18918.716219256723;18940;18968.14643341053;7690.077190737035;7797.259260370256;7865.724699635485;7871.567063811545;7921.287084162453;4513.345564893072;4521.409767633235;4582.693932229366;4643.094596553639;4644.3265726470145;2933.1054028521507;2952.143878275276;2958.65975412826;2962.1113665900143;2971.435427268855;541.2557733116964;548.4378512025127;549.5219159331407;552.078029690418;553.2006250967394;564.7882044233412;661.715462351184;665.8335416145964;667.3620414357727;684.5892464521247;7670.160197656851;7786.883196752054;7904.130545639975;8122.228388303101;8130.918690813134;501.657349230696;533.1363191629507;543.3127094225807;576.3516044449993;701.7052837808133;3643.5081264029545;3740.9064773380883;4208.642265407475;4267.615914567704;4314.288142456459;52108.47891521112;53192.73403632957;53544.46455535472;53612.73193634007;54113;49784.50215497871;49865.50134498681;53315.73342133265;55218.44781552214;56821;44492.77753611276;44562.554374456486;45211.773941130086;45423;46166.76916615463;8363.330933525425;8403.873941890753;8419.831603367777;8570.228679418882;8702.956485217534;33841.49237761485;34524.654753452145;34791.82604086964;34915.65084349124;35359;39202.411963821134;43353.56646433622;43589.346159808265;43833.78083109564;44435;10470.528826202992;10659.840102398626;10786.622468213574;10822.621208257673;11119.944400277947;11597.5360985563;11896;11898.167128300936;11899.643010709346;11971.401429928643;10792.838107428552;10819.621313253998;10930.617428389969;10941.890581094087;10985.340879546933;11270.098392128773;11303;11392.829107563559;11420;11527.481263343001;10040.64857729976;10189.490525473548;10578.788424231627;10685.626003089854;10791.352518848895;9132.954335228282;9137.49863700798;9360.204382627553;9638.373505722106;9713.337597952881;8735.73792786192;9008;9377.906220937975;9444.52777361143;9475.857862132212 14:17:51 INFO - PROCESS | 5372 | __end_tp_report 14:17:51 INFO - PROCESS | 5372 | __start_cc_report 14:17:51 INFO - PROCESS | 5372 | _x_x_mozilla_cycle_collect,321 14:17:51 INFO - PROCESS | 5372 | __end_cc_report 14:17:51 INFO - PROCESS | 5372 | __startTimestamp1451427471244__endTimestamp 14:17:51 INFO - PROCESS | 5372 | 14:17:51 INFO - PROCESS | 5372 | ------- Summary: start ------- 14:17:51 INFO - PROCESS | 5372 | Number of tests: 6 14:17:51 INFO - PROCESS | 5372 | 14:17:51 INFO - PROCESS | 5372 | [#0] dojo.html Cycles:165 Average:5294.72 Median:5483.29 stddev:578.10 (10.5%) stddev-sans-first:555.31 14:17:51 INFO - PROCESS | 5372 | Values: 3169.5 3228.2 3259.2 3267.8 3277.1 5206.2 5326.5 5359.9 5360.0 5369.1 5190.0 5234.3 5276.7 5281.9 5317.9 4480.4 4762.9 4910.8 4920.8 4922.8 4754.9 4841.0 4898.2 4909.1 4934.0 4793.6 4808.1 4842.2 4895.9 4943.6 4850.2 4856.6 4881.6 4884.4 4904.7 4688.2 4811.4 4824.8 4841.2 4847.2 5066.9 5090.5 5139.1 5146.2 5181.6 5720.3 5722.5 5726.5 5727.5 5734.5 5605.9 5740.4 5763.7 5764.3 5766.3 5343.1 5412.7 5412.8 5432.2 5432.8 5851.5 5897.0 5900.6 5909.0 5919.3 5529.9 5644.0 5651.4 5663.9 5677.8 5663.3 5664.3 5664.7 5699.1 5714.5 5585.8 5631.2 5636.6 5649.1 5661.2 5608.5 5615.5 5623.1 5636.4 5668.9 4416.9 4436.8 4458.6 4462.1 4500.7 3903.5 3916.8 3936.9 3940.0 3973.1 5229.8 5318.1 5344.3 5397.6 5414.2 5722.4 5745.7 5748.5 5762.8 5772.0 5387.6 5398.5 5399.2 5400.9 5409.0 4882.9 4943.5 4952.4 4972.8 5036.9 5933.9 5952.6 5953.6 5960.3 5966.0 5715.5 5729.8 5743.6 5745.2 5748.5 5728.7 5808.2 5857.1 5933.3 5942.4 5631.7 5644.9 5649.7 5650.7 5653.3 5547.8 5698.7 5708.4 5762.0 5762.5 5477.9 5557.7 5558.3 5562.7 5597.4 5508.8 5510.1 5511.2 5528.8 5533.9 5332.5 5458.4 5483.3 5487.6 5533.8 5488.0 5541.2 5563.1 5571.0 5576.9 5364.8 5441.8 5454.4 5455.5 5488.2 14:17:51 INFO - PROCESS | 5372 | 14:17:51 INFO - PROCESS | 5372 | [#1] ext.html Cycles:180 Average:45710.68 Median:19192.36 stddev:77093.91 (401.7%) stddev-sans-first:77235.49 14:17:51 INFO - PROCESS | 5372 | Values: 512.2 545.4 549.1 553.6 553.8 34304.8 35251.8 35266.8 35369.6 35391.3 40311.0 40846.6 40892.6 40977.6 41182.0 8672.7 8907.8 8912.2 8912.9 8913.2 8541.0 8720.7 8780.0 8784.3 8788.0 8784.7 8879.5 8903.4 8909.2 8915.5 8718.3 8800.4 8811.0 8827.6 8831.8 8644.5 8730.6 8731.7 8769.7 8796.6 38333.0 38476.4 38746.8 38750.6 38818.8 3249.7 3250.6 3251.2 3251.9 3262.0 29134.0 29313.9 29383.7 29645.7 29848.1 3496.1 3500.8 3513.5 3579.4 3617.8 249851.0 249930.0 251445.0 252040.0 252164.0 49362.0 50352.7 55115.7 55404.8 55661.7 60145.4 61286.7 61356.0 61976.4 62020.7 13612.9 13770.2 13776.6 13778.6 13783.2 10101.9 10201.3 10244.3 10270.7 10324.3 18033.5 18145.5 18229.5 18233.3 18971.3 7516.6 7551.2 7716.2 7771.4 7799.6 967.1 980.4 1021.5 1077.5 1111.1 28887.4 32039.8 32048.8 32098.8 32216.2 1072.3 1086.1 1094.6 1129.0 1154.4 14396.8 14607.2 14631.9 14862.6 14909.3 319980.0 321267.0 324029.0 324699.0 325166.0 50540.5 50758.5 50837.0 51098.7 51295.7 1310.5 1328.7 1338.5 1339.0 1340.2 27724.7 28277.7 28368.9 28401.6 28677.9 45317.5 45815.6 45884.3 45915.1 45926.6 303366.0 305174.0 305384.0 305809.0 305823.0 30521.1 31068.0 31392.0 31865.7 32120.8 41277.6 41377.4 41729.8 42225.4 42400.0 34428.3 35071.8 35233.5 35298.8 35760.3 34742.5 34888.7 35074.3 35336.0 35411.1 31638.4 31990.7 32019.2 32139.4 35752.5 27784.2 29893.0 32075.0 32161.8 32223.2 24246.3 24811.3 25099.7 25111.6 25301.5 14:17:51 INFO - PROCESS | 5372 | 14:17:51 INFO - PROCESS | 5372 | [#2] jquery.html Cycles:180 Average:28541.48 Median:18020.72 stddev:90055.12 (499.7%) stddev-sans-first:90282.87 14:17:51 INFO - PROCESS | 5372 | Values: 351.8 352.6 354.7 356.8 357.2 16227.3 16408.7 17038.4 17203.7 17844.3 13982.0 14106.2 14109.9 14118.1 14367.9 4482.5 4753.5 5014.2 5058.9 5073.5 4960.8 4968.5 4972.1 4980.3 4982.8 4860.0 4953.8 5049.5 5177.6 5197.7 4321.3 5143.4 5183.8 5230.2 5623.5 5226.6 5237.3 5263.5 5265.6 5267.4 12636.4 12739.5 20032.8 20498.2 20584.3 2086.9 2089.8 2155.5 2180.3 2244.2 9505.3 9803.4 9868.9 11835.6 12591.6 1726.2 1793.2 1827.5 1841.8 1883.1 57937.1 60439.4 60775.7 61879.1 62818.7 9979.2 10155.2 10235.7 10267.2 10289.5 13478.9 13506.5 13509.4 13510.6 13533.1 7123.2 7184.1 7190.4 7222.3 7230.1 6636.3 6710.4 6727.2 6745.6 6746.7 4330.8 4384.3 4384.7 4454.0 4484.3 1723.5 1778.3 1850.9 1855.5 1870.3 831.9 886.5 985.2 1025.3 1026.1 16459.8 16471.8 16659.3 16695.9 16808.6 908.2 909.1 917.5 967.2 984.5 9459.0 9609.5 9627.1 9658.9 9883.1 536284.0 548235.0 552149.0 558983.0 561717.0 45141.1 77781.0 78591.6 79883.0 80868.6 1068.7 1078.1 1092.8 1109.8 1116.0 14777.4 14941.7 15166.2 15182.4 15383.0 32350.0 32564.7 33979.2 35684.3 37121.4 43260.4 43451.1 43896.0 44454.8 45745.8 9189.9 9338.8 9445.3 9531.3 9581.3 11318.7 11445.6 11511.7 14079.5 17559.6 12531.5 13984.9 14389.2 14749.4 14807.9 14120.8 14210.8 14366.1 14394.6 14845.2 14446.6 14595.8 14630.1 14749.5 14760.8 9341.4 9434.8 9437.8 9610.4 9612.3 10158.0 10200.5 12775.4 13981.7 14196.9 14:17:51 INFO - PROCESS | 5372 | 14:17:51 INFO - PROCESS | 5372 | [#3] mootools.html Cycles:180 Average:4838.63 Median:5893.88 stddev:2384.09 (40.5%) stddev-sans-first:2376.76 14:17:51 INFO - PROCESS | 5372 | Values: 1399.5 1416.0 1515.4 1686.7 1700.2 6753.6 6803.6 6835.1 6898.7 6913.2 6924.3 6943.4 7006.1 7012.1 7012.9 2138.8 2163.4 2165.3 2169.6 2176.3 2140.1 2178.7 2188.3 2189.1 2194.2 2105.2 2126.4 2152.1 2156.6 2164.6 2143.4 2176.2 2199.2 2206.7 2218.1 2173.5 2174.8 2197.7 2198.6 2201.4 6819.8 6964.8 6971.4 6976.2 6981.7 4157.0 4225.1 4233.8 4256.4 4261.9 2765.5 2829.5 2843.8 2849.1 2863.9 936.4 940.2 941.5 954.3 974.8 8659.3 8778.8 8828.1 8839.9 8931.6 3746.2 3750.7 3848.0 3850.1 3872.8 7867.2 7869.6 7881.1 7914.9 7922.2 4141.4 4172.8 4224.8 4272.8 4272.9 3911.0 3912.8 3920.3 3921.4 3958.8 3270.7 3272.4 3319.1 3356.3 3360.2 1062.3 1066.9 1081.1 1094.6 1101.1 1013.0 1017.0 1116.4 1163.1 1266.7 6358.8 6365.7 6419.8 6441.4 6446.8 1091.8 1100.3 1128.6 1131.7 1141.6 4868.0 4915.9 5036.5 5236.0 5236.6 7789.9 7930.8 7970.8 8153.1 8188.1 7910.4 7988.4 8008.2 8068.6 8169.8 6541.3 6578.5 6594.1 6599.9 6649.5 6228.0 6234.4 6311.1 6331.6 6368.7 7286.7 7308.7 7378.4 7394.7 7405.7 7680.9 7694.0 7713.5 7743.5 7770.4 5729.0 5872.0 5872.5 5876.7 5901.7 6321.3 6372.6 6386.1 6391.3 6399.8 5963.5 6049.7 6068.1 6148.0 6177.9 6075.2 6092.8 6095.3 6197.5 6222.9 6142.8 6161.4 6165.6 6169.4 6180.0 5748.5 5766.6 5789.1 5794.7 5807.2 5762.3 5886.0 5908.2 5924.0 5925.4 14:17:51 INFO - PROCESS | 5372 | 14:17:51 INFO - PROCESS | 5372 | [#4] prototype.html Cycles:180 Average:5619.02 Median:6335.84 stddev:1730.40 (27.3%) stddev-sans-first:1689.19 14:17:51 INFO - PROCESS | 5372 | Values: 335.2 335.7 340.4 341.4 349.3 6309.0 6327.9 6337.9 6396.3 6422.8 6215.8 6256.4 6312.4 6313.8 6359.2 4755.0 4771.4 4779.8 4782.2 4787.4 4746.0 4751.3 4788.4 4794.1 4795.7 4597.6 4713.2 4717.5 4735.3 4746.6 4731.9 4747.8 4754.3 4760.2 4765.4 4135.7 4144.3 4151.3 4157.0 4167.0 6024.9 6046.7 6050.7 6057.7 6073.1 5497.8 5576.9 5587.6 5591.3 5598.7 6692.6 6694.4 6710.7 6712.6 6722.3 4600.1 4613.6 4620.1 4630.1 4637.0 6849.8 7004.6 7025.0 7036.0 7043.1 4630.5 4637.1 4648.4 4649.5 4652.2 4695.1 4707.1 4710.5 4711.2 4714.2 5477.5 5488.7 5506.1 5512.1 5515.1 6494.7 6650.2 6658.9 6674.0 6740.9 1648.1 1656.9 1690.0 1690.8 1692.0 1068.6 1120.6 1132.3 1137.3 1143.8 6222.3 6332.2 6347.6 6355.8 6366.5 6902.9 6915.7 6919.1 6920.8 6926.8 6260.4 6291.6 6333.7 6338.1 6361.6 3771.4 3792.7 3799.2 3802.7 3844.5 7351.6 7352.4 7354.1 7356.3 7356.8 7045.6 7188.3 7197.1 7204.4 7221.4 7258.1 7277.4 7306.7 7308.6 7320.1 7059.4 7061.9 7065.7 7067.6 7076.2 6776.2 6922.7 6952.8 6985.4 6990.2 7289.7 7299.1 7304.3 7311.2 7324.4 4616.5 4639.0 4648.0 4651.9 4657.5 6869.9 6870.8 6959.4 7071.4 7083.8 6783.7 6789.5 6825.8 6833.3 6883.8 6769.8 6785.2 6829.2 6836.2 6841.4 6603.8 6654.3 6686.4 6730.5 6739.4 6844.7 6884.5 6885.2 6888.3 6890.8 6582.1 6613.1 6620.1 6623.0 6658.7 14:17:51 INFO - PROCESS | 5372 | 14:17:51 INFO - PROCESS | 5372 | [#5] yui.html Cycles:180 Average:13578.31 Median:25002.85 stddev:15550.89 (62.2%) stddev-sans-first:15564.87 14:17:51 INFO - PROCESS | 5372 | Values: 792.3 798.3 825.2 857.8 869.9 13034.7 13275.9 13276.4 13368.1 13388.5 13014.6 13070.3 13099.1 13105.9 13118.9 815.0 818.2 833.0 834.7 839.6 820.5 822.1 822.3 827.7 829.2 869.1 873.3 873.4 873.6 873.7 869.9 871.8 872.5 873.7 875.0 640.1 642.2 643.5 643.7 645.3 14052.4 14143.6 14148.1 14160.3 14168.2 12222.7 12244.6 12426.9 12454.5 12813.0 10169.7 10364.6 10364.8 10365.2 10716.0 3564.6 3635.3 3640.9 3769.3 3791.4 46649.5 47026.5 47202.5 47534.0 47612.5 10203.1 10223.7 10228.6 10343.3 10404.5 18608.2 18897.8 18918.7 18940.0 18968.1 7690.1 7797.3 7865.7 7871.6 7921.3 4513.3 4521.4 4582.7 4643.1 4644.3 2933.1 2952.1 2958.7 2962.1 2971.4 541.3 548.4 549.5 552.1 553.2 564.8 661.7 665.8 667.4 684.6 7670.2 7786.9 7904.1 8122.2 8130.9 501.7 533.1 543.3 576.4 701.7 3643.5 3740.9 4208.6 4267.6 4314.3 52108.5 53192.7 53544.5 53612.7 54113.0 49784.5 49865.5 53315.7 55218.4 56821.0 44492.8 44562.6 45211.8 45423.0 46166.8 8363.3 8403.9 8419.8 8570.2 8703.0 33841.5 34524.7 34791.8 34915.7 35359.0 39202.4 43353.6 43589.3 43833.8 44435.0 10470.5 10659.8 10786.6 10822.6 11119.9 11597.5 11896.0 11898.2 11899.6 11971.4 10792.8 10819.6 10930.6 10941.9 10985.3 11270.1 11303.0 11392.8 11420.0 11527.5 10040.6 10189.5 10578.8 10685.6 10791.4 9133.0 9137.5 9360.2 9638.4 9713.3 8735.7 9008.0 9377.9 9444.5 9475.9 14:17:51 INFO - PROCESS | 5372 | -------- Summary: end -------- 14:17:51 INFO - PROCESS | 5372 | 14:17:51 INFO - TEST-INFO | 5372: exit 0 14:17:51 INFO - TEST-OK | dromaeo_css | took 1110946ms 14:17:51 INFO - TEST-START | kraken 14:17:51 INFO - operating with platform_type : linux_ 14:17:51 INFO - Initialising browser for kraken test... 14:17:51 INFO - TEST-INFO | started process 5613 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6V_h0V/profile http://localhost:34368/getInfo.html) 14:17:56 INFO - PROCESS | 5613 | __metrics Screen width/height:1600/1200 14:17:56 INFO - PROCESS | 5613 | colorDepth:24 14:17:56 INFO - PROCESS | 5613 | Browser inner width/height: 1024/697 14:17:56 INFO - PROCESS | 5613 | __metrics 14:17:56 INFO - PROCESS | 5613 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:17:57 INFO - TEST-INFO | 5613: exit 0 14:17:57 INFO - Browser initialized. 14:17:57 INFO - Running cycle 1/1 for kraken test... 14:17:57 INFO - TEST-INFO | started process 5734 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6V_h0V/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:18:09 INFO - PROCESS | 5734 | RSS: Main: 149659648 14:18:09 INFO - PROCESS | 5734 | 14:18:11 INFO - PROCESS | 5734 | Cycle 1(1): loaded http://localhost:34368/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34368/tests/kraken/driver.html?testName=audio-beat-detection) 14:18:12 INFO - PROCESS | 5734 | RSS: Main: 151519232 14:18:12 INFO - PROCESS | 5734 | 14:18:14 INFO - PROCESS | 5734 | Cycle 1(1): loaded http://localhost:34368/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34368/tests/kraken/driver.html?testName=audio-dft) 14:18:15 INFO - PROCESS | 5734 | RSS: Main: 152039424 14:18:15 INFO - PROCESS | 5734 | 14:18:18 INFO - PROCESS | 5734 | Cycle 1(1): loaded http://localhost:34368/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34368/tests/kraken/driver.html?testName=audio-fft) 14:18:18 INFO - PROCESS | 5734 | RSS: Main: 145330176 14:18:18 INFO - PROCESS | 5734 | 14:18:20 INFO - PROCESS | 5734 | Cycle 1(1): loaded http://localhost:34368/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34368/tests/kraken/driver.html?testName=audio-oscillator) 14:18:21 INFO - PROCESS | 5734 | RSS: Main: 146108416 14:18:21 INFO - PROCESS | 5734 | 14:18:23 INFO - PROCESS | 5734 | Cycle 1(1): loaded http://localhost:34368/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34368/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:18:24 INFO - PROCESS | 5734 | RSS: Main: 146493440 14:18:24 INFO - PROCESS | 5734 | 14:18:27 INFO - PROCESS | 5734 | Cycle 1(1): loaded http://localhost:34368/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34368/tests/kraken/driver.html?testName=imaging-darkroom) 14:18:27 INFO - PROCESS | 5734 | RSS: Main: 146722816 14:18:27 INFO - PROCESS | 5734 | 14:18:31 INFO - PROCESS | 5734 | Cycle 1(1): loaded http://localhost:34368/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34368/tests/kraken/driver.html?testName=imaging-desaturate) 14:18:31 INFO - PROCESS | 5734 | RSS: Main: 148086784 14:18:31 INFO - PROCESS | 5734 | 14:18:34 INFO - PROCESS | 5734 | Cycle 1(1): loaded http://localhost:34368/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34368/tests/kraken/driver.html?testName=json-parse-financial) 14:18:35 INFO - PROCESS | 5734 | RSS: Main: 148697088 14:18:35 INFO - PROCESS | 5734 | 14:18:36 INFO - PROCESS | 5734 | Cycle 1(1): loaded http://localhost:34368/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34368/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:18:37 INFO - PROCESS | 5734 | RSS: Main: 147566592 14:18:37 INFO - PROCESS | 5734 | 14:18:39 INFO - PROCESS | 5734 | Cycle 1(1): loaded http://localhost:34368/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34368/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:18:39 INFO - PROCESS | 5734 | RSS: Main: 148791296 14:18:39 INFO - PROCESS | 5734 | 14:18:42 INFO - PROCESS | 5734 | Cycle 1(1): loaded http://localhost:34368/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34368/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:18:42 INFO - PROCESS | 5734 | RSS: Main: 148951040 14:18:42 INFO - PROCESS | 5734 | 14:18:45 INFO - PROCESS | 5734 | Cycle 1(1): loaded http://localhost:34368/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34368/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:18:45 INFO - PROCESS | 5734 | RSS: Main: 149356544 14:18:45 INFO - PROCESS | 5734 | 14:18:48 INFO - PROCESS | 5734 | Cycle 1(1): loaded http://localhost:34368/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34368/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:18:48 INFO - PROCESS | 5734 | RSS: Main: 148324352 14:18:48 INFO - PROCESS | 5734 | 14:18:50 INFO - PROCESS | 5734 | Cycle 1(1): loaded http://localhost:34368/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34368/tests/kraken/driver.html?testName=ai-astar) 14:18:50 INFO - PROCESS | 5734 | RSS: Main: 148373504 14:18:50 INFO - PROCESS | 5734 | 14:18:50 INFO - PROCESS | 5734 | __start_tp_report 14:18:50 INFO - PROCESS | 5734 | _x_x_mozilla_page_load 14:18:50 INFO - PROCESS | 5734 | _x_x_mozilla_page_load_details 14:18:50 INFO - PROCESS | 5734 | |i|pagename|runs| 14:18:50 INFO - PROCESS | 5734 | |0;ai-astar;112;109;112;112;112;123;112;112;112;114 14:18:50 INFO - PROCESS | 5734 | |1;audio-beat-detection;152;133;151;169;126;159;160;132;169;130 14:18:50 INFO - PROCESS | 5734 | |2;audio-dft;162;163;161;162;164;160;160;164;170;162 14:18:50 INFO - PROCESS | 5734 | |3;audio-fft;75;71;75;73;72;72;137;75;72;72 14:18:50 INFO - PROCESS | 5734 | |4;audio-oscillator;96;96;138;95;97;97;147;97;96;136 14:18:50 INFO - PROCESS | 5734 | |5;imaging-gaussian-blur;110;110;109;109;110;109;110;110;110;110 14:18:50 INFO - PROCESS | 5734 | |6;imaging-darkroom;149;147;147;146;147;146;147;148;146;147 14:18:50 INFO - PROCESS | 5734 | |7;imaging-desaturate;97;96;96;96;96;96;96;96;96;97 14:18:50 INFO - PROCESS | 5734 | |8;json-parse-financial;60;60;59;60;62;60;61;61;61;59 14:18:50 INFO - PROCESS | 5734 | |9;json-stringify-tinderbox;68;68;67;68;68;68;68;67;68;68 14:18:50 INFO - PROCESS | 5734 | |10;stanford-crypto-aes;86;86;88;87;87;88;87;88;87;88 14:18:50 INFO - PROCESS | 5734 | |11;stanford-crypto-ccm;123;126;119;134;124;118;117;123;122;116 14:18:50 INFO - PROCESS | 5734 | |12;stanford-crypto-pbkdf2;141;144;150;150;152;148;152;150;155;142 14:18:50 INFO - PROCESS | 5734 | |13;stanford-crypto-sha256-iterative;69;68;71;67;68;67;67;69;67;67 14:18:50 INFO - PROCESS | 5734 | __end_tp_report 14:18:50 INFO - PROCESS | 5734 | __start_cc_report 14:18:50 INFO - PROCESS | 5734 | _x_x_mozilla_cycle_collect,745 14:18:50 INFO - PROCESS | 5734 | __end_cc_report 14:18:50 INFO - PROCESS | 5734 | __startTimestamp1451427530777__endTimestamp 14:18:50 INFO - PROCESS | 5734 | 14:18:50 INFO - PROCESS | 5734 | ------- Summary: start ------- 14:18:50 INFO - PROCESS | 5734 | Number of tests: 14 14:18:50 INFO - PROCESS | 5734 | 14:18:50 INFO - PROCESS | 5734 | [#0] ai-astar Cycles:10 Average:113.00 Median:112.00 stddev:3.71 (3.3%) stddev-sans-first:3.92 14:18:50 INFO - PROCESS | 5734 | Values: 112.0 109.0 112.0 112.0 112.0 123.0 112.0 112.0 112.0 114.0 14:18:50 INFO - PROCESS | 5734 | 14:18:50 INFO - PROCESS | 5734 | [#1] audio-beat-detection Cycles:10 Average:148.10 Median:155.50 stddev:16.54 (10.6%) stddev-sans-first:17.48 14:18:50 INFO - PROCESS | 5734 | Values: 152.0 133.0 151.0 169.0 126.0 159.0 160.0 132.0 169.0 130.0 14:18:50 INFO - PROCESS | 5734 | 14:18:50 INFO - PROCESS | 5734 | [#2] audio-dft Cycles:10 Average:162.80 Median:162.50 stddev:2.90 (1.8%) stddev-sans-first:3.06 14:18:50 INFO - PROCESS | 5734 | Values: 162.0 163.0 161.0 162.0 164.0 160.0 160.0 164.0 170.0 162.0 14:18:50 INFO - PROCESS | 5734 | 14:18:50 INFO - PROCESS | 5734 | [#3] audio-fft Cycles:10 Average:79.40 Median:72.50 stddev:20.29 (28.0%) stddev-sans-first:21.46 14:18:50 INFO - PROCESS | 5734 | Values: 75.0 71.0 75.0 73.0 72.0 72.0 137.0 75.0 72.0 72.0 14:18:50 INFO - PROCESS | 5734 | 14:18:50 INFO - PROCESS | 5734 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:96.00 stddev:21.46 (22.4%) stddev-sans-first:22.20 14:18:50 INFO - PROCESS | 5734 | Values: 96.0 96.0 138.0 95.0 97.0 97.0 147.0 97.0 96.0 136.0 14:18:50 INFO - PROCESS | 5734 | 14:18:50 INFO - PROCESS | 5734 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 14:18:50 INFO - PROCESS | 5734 | Values: 110.0 110.0 109.0 109.0 110.0 109.0 110.0 110.0 110.0 110.0 14:18:50 INFO - PROCESS | 5734 | 14:18:50 INFO - PROCESS | 5734 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.94 (0.6%) stddev-sans-first:0.67 14:18:50 INFO - PROCESS | 5734 | Values: 149.0 147.0 147.0 146.0 147.0 146.0 147.0 148.0 146.0 147.0 14:18:50 INFO - PROCESS | 5734 | 14:18:50 INFO - PROCESS | 5734 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 14:18:50 INFO - PROCESS | 5734 | Values: 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 14:18:50 INFO - PROCESS | 5734 | 14:18:50 INFO - PROCESS | 5734 | [#8] json-parse-financial Cycles:10 Average:60.30 Median:60.50 stddev:0.95 (1.6%) stddev-sans-first:1.00 14:18:50 INFO - PROCESS | 5734 | Values: 60.0 60.0 59.0 60.0 62.0 60.0 61.0 61.0 61.0 59.0 14:18:50 INFO - PROCESS | 5734 | 14:18:50 INFO - PROCESS | 5734 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 14:18:50 INFO - PROCESS | 5734 | Values: 68.0 68.0 67.0 68.0 68.0 68.0 68.0 67.0 68.0 68.0 14:18:50 INFO - PROCESS | 5734 | 14:18:50 INFO - PROCESS | 5734 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:87.50 stddev:0.79 (0.9%) stddev-sans-first:0.71 14:18:50 INFO - PROCESS | 5734 | Values: 86.0 86.0 88.0 87.0 87.0 88.0 87.0 88.0 87.0 88.0 14:18:50 INFO - PROCESS | 5734 | 14:18:50 INFO - PROCESS | 5734 | [#11] stanford-crypto-ccm Cycles:10 Average:122.20 Median:123.00 stddev:5.29 (4.3%) stddev-sans-first:5.60 14:18:50 INFO - PROCESS | 5734 | Values: 123.0 126.0 119.0 134.0 124.0 118.0 117.0 123.0 122.0 116.0 14:18:50 INFO - PROCESS | 5734 | 14:18:50 INFO - PROCESS | 5734 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.40 Median:150.00 stddev:4.62 (3.1%) stddev-sans-first:4.06 14:18:50 INFO - PROCESS | 5734 | Values: 141.0 144.0 150.0 150.0 152.0 148.0 152.0 150.0 155.0 142.0 14:18:50 INFO - PROCESS | 5734 | 14:18:50 INFO - PROCESS | 5734 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:1.33 (2.0%) stddev-sans-first:1.36 14:18:50 INFO - PROCESS | 5734 | Values: 69.0 68.0 71.0 67.0 68.0 67.0 67.0 69.0 67.0 67.0 14:18:50 INFO - PROCESS | 5734 | -------- Summary: end -------- 14:18:50 INFO - PROCESS | 5734 | 14:18:51 INFO - TEST-INFO | 5734: exit 0 14:18:51 INFO - TEST-OK | kraken | took 60056ms 14:18:51 INFO - TEST-START | v8_7 14:18:51 INFO - operating with platform_type : linux_ 14:18:51 INFO - Initialising browser for v8_7 test... 14:18:51 INFO - TEST-INFO | started process 6018 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfL9bhm/profile http://localhost:34368/getInfo.html) 14:18:56 INFO - PROCESS | 6018 | __metrics Screen width/height:1600/1200 14:18:56 INFO - PROCESS | 6018 | colorDepth:24 14:18:56 INFO - PROCESS | 6018 | Browser inner width/height: 1024/697 14:18:56 INFO - PROCESS | 6018 | __metrics 14:18:56 INFO - PROCESS | 6018 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:18:57 INFO - TEST-INFO | 6018: exit 0 14:18:57 INFO - Browser initialized. 14:18:57 INFO - Running cycle 1/1 for v8_7 test... 14:18:57 INFO - TEST-INFO | started process 6143 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfL9bhm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:19:09 INFO - PROCESS | 6143 | RSS: Main: 149495808 14:19:09 INFO - PROCESS | 6143 | 14:19:30 INFO - PROCESS | 6143 | Cycle 1(1): loaded http://localhost:34368/tests/v8_7/run.html (next: http://localhost:34368/tests/v8_7/run.html) 14:19:31 INFO - PROCESS | 6143 | RSS: Main: 146259968 14:19:31 INFO - PROCESS | 6143 | 14:19:31 INFO - PROCESS | 6143 | __start_tp_report 14:19:31 INFO - PROCESS | 6143 | _x_x_mozilla_page_load 14:19:31 INFO - PROCESS | 6143 | _x_x_mozilla_page_load_details 14:19:31 INFO - PROCESS | 6143 | |i|pagename|runs| 14:19:31 INFO - PROCESS | 6143 | |0;Richards;166.8335001668335 14:19:31 INFO - PROCESS | 6143 | |1;DeltaBlue;188.7504718761797 14:19:31 INFO - PROCESS | 6143 | |2;Encrypt;282.88543140028287 14:19:31 INFO - PROCESS | 6143 | |3;Decrypt;5263.1578947368425 14:19:31 INFO - PROCESS | 6143 | |4;RayTrace;1062.6992561105208 14:19:31 INFO - PROCESS | 6143 | |5;Earley;729.3946024799417 14:19:31 INFO - PROCESS | 6143 | |6;Boyer;12456.79012345679 14:19:31 INFO - PROCESS | 6143 | |7;RegExp;24951.219512195123 14:19:31 INFO - PROCESS | 6143 | |8;Splay;571.1022272986864 14:19:31 INFO - PROCESS | 6143 | |9;NavierStokes;4826.923076923077 14:19:31 INFO - PROCESS | 6143 | __end_tp_report 14:19:31 INFO - PROCESS | 6143 | __startTimestamp1451427571027__endTimestamp 14:19:31 INFO - PROCESS | 6143 | 14:19:31 INFO - PROCESS | 6143 | ------- Summary: start ------- 14:19:31 INFO - PROCESS | 6143 | Number of tests: 10 14:19:31 INFO - PROCESS | 6143 | 14:19:31 INFO - PROCESS | 6143 | [#0] Richards Cycles:1 Average:166.83 Median:166.83 stddev:0.00 (0.0%) 14:19:31 INFO - PROCESS | 6143 | Values: 166.8 14:19:31 INFO - PROCESS | 6143 | 14:19:31 INFO - PROCESS | 6143 | [#1] DeltaBlue Cycles:1 Average:188.75 Median:188.75 stddev:0.00 (0.0%) 14:19:31 INFO - PROCESS | 6143 | Values: 188.8 14:19:31 INFO - PROCESS | 6143 | 14:19:31 INFO - PROCESS | 6143 | [#2] Encrypt Cycles:1 Average:282.89 Median:282.89 stddev:0.00 (0.0%) 14:19:31 INFO - PROCESS | 6143 | Values: 282.9 14:19:31 INFO - PROCESS | 6143 | 14:19:31 INFO - PROCESS | 6143 | [#3] Decrypt Cycles:1 Average:5263.16 Median:5263.16 stddev:0.00 (0.0%) 14:19:31 INFO - PROCESS | 6143 | Values: 5263.2 14:19:31 INFO - PROCESS | 6143 | 14:19:31 INFO - PROCESS | 6143 | [#4] RayTrace Cycles:1 Average:1062.70 Median:1062.70 stddev:0.00 (0.0%) 14:19:31 INFO - PROCESS | 6143 | Values: 1062.7 14:19:31 INFO - PROCESS | 6143 | 14:19:31 INFO - PROCESS | 6143 | [#5] Earley Cycles:1 Average:729.39 Median:729.39 stddev:0.00 (0.0%) 14:19:31 INFO - PROCESS | 6143 | Values: 729.4 14:19:31 INFO - PROCESS | 6143 | 14:19:31 INFO - PROCESS | 6143 | [#6] Boyer Cycles:1 Average:12456.79 Median:12456.79 stddev:0.00 (0.0%) 14:19:31 INFO - PROCESS | 6143 | Values: 12456.8 14:19:31 INFO - PROCESS | 6143 | 14:19:31 INFO - PROCESS | 6143 | [#7] RegExp Cycles:1 Average:24951.22 Median:24951.22 stddev:0.00 (0.0%) 14:19:31 INFO - PROCESS | 6143 | Values: 24951.2 14:19:31 INFO - PROCESS | 6143 | 14:19:31 INFO - PROCESS | 6143 | [#8] Splay Cycles:1 Average:571.10 Median:571.10 stddev:0.00 (0.0%) 14:19:31 INFO - PROCESS | 6143 | Values: 571.1 14:19:31 INFO - PROCESS | 6143 | 14:19:31 INFO - PROCESS | 6143 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 14:19:31 INFO - PROCESS | 6143 | Values: 4826.9 14:19:31 INFO - PROCESS | 6143 | -------- Summary: end -------- 14:19:31 INFO - PROCESS | 6143 | 14:19:31 INFO - TEST-INFO | 6143: exit 0 14:19:31 INFO - TEST-OK | v8_7 | took 39901ms 14:19:31 INFO - SUITE-END | took 1210s 14:19:32 INFO - Completed test suite (00:20:11) 14:19:32 INFO - Working with test: dromaeo_css 14:19:32 INFO - Generating results file: dromaeo_css 14:19:32 INFO - Working with test: kraken 14:19:32 INFO - Generating results file: kraken 14:19:32 INFO - javascript benchmark 14:19:32 INFO - Working with test: v8_7 14:19:32 INFO - Generating results file: v8_7 14:19:32 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:19:32 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 14:19:32 INFO - process_Request line: dromaeo_css 6861.17 graph.html#tests=[[72,64,43]] 14:19:32 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:19:32 INFO - process_Request line: kraken 1519.60 graph.html#tests=[[232,64,43]] 14:19:32 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:19:32 INFO - process_Request line: v8_7 21386.18 graph.html#tests=[[230,64,43]] 14:19:32 INFO - RETURN: dromaeo_css: 6861.17 14:19:32 INFO - RETURN: kraken: 1519.60 14:19:32 INFO - RETURN: v8_7: 21386.18 14:19:32 INFO - javascript benchmark 14:19:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3169.4770362890126, 3228.2413632796274, 3259.1852036990754, 3267.8039317640937, 3277.082416923261, 5206.245094461301, 5326.467353264671, 5359.946400535993, 5360.035193665134, 5369.060414427474, 5190.013897359499, 5234.293370394996, 5276.736163191844, 5281.947180528203, 5317.867053323669, 4480.417545719052, 4762.857114286577, 4910.75446227689, 4920.778564964585, 4922.80308787648, 4754.85735427936, 4840.9757951210195, 4898.167311557026, 4909.091818013679, 4934.037862616791, 4793.616510679138, 4808.110499557575, 4842.225243960949, 4895.853124406238, 4943.555080042777, 4850.175470170079, 4856.587190088847, 4881.633877459205, 4884.438289596671, 4904.656674032819, 4688.156131896258, 4811.422629284473, 4824.7828847701585, 4841.15279826029, 4847.151748444008, 5066.898662026776, 5090.516400941905, 5139.100657384943, 5146.176611742103, 5181.5854731621375, 5720.342160651495, 5722.513586345166, 5726.513246374063, 5727.455891690282, 5734.512566431817, 5605.943940560583, 5740.425957404268, 5763.740631671543, 5764.250647415851, 5766.274976449023, 5343.118385466393, 5412.675239485604, 5412.810551630674, 5432.212329212242, 5432.75552600134, 5851.502622277069, 5897.0, 5900.616459930091, 5909.025010873243, 5919.260092488439, 5529.889402211933, 5643.984082865124, 5651.350094739076, 5663.886722265532, 5677.772889084473, 5663.263775709132, 5664.291963504562, 5664.660120392789, 5699.088145896637, 5714.514266287412, 5585.832425027255, 5631.211630371751, 5636.633618814764, 5649.096144616841, 5661.150827375926, 5608.46719561641, 5615.494605485526, 5623.072193088176, 5636.436356364331, 5668.943310566841, 4416.867493975186, 4436.778161091933, 4458.643308535309, 4462.062966776948, 4500.729956202638, 3903.4535165076913, 3916.7845768483007, 3936.9212615747524, 3940.0346915006007, 3973.0861901762755, 5229.816956406507, 5318.12250978592, 5344.331958505187, 5397.622166448311, 5414.160805075219, 5722.399148089391, 5745.741441635137, 5748.48263656273, 5762.827115186551, 5771.9711401443565, 5387.595930305243, 5398.541124004425, 5399.163129714901, 5400.91898621521, 5408.972955135199, 4882.926756098661, 4943.505649435027, 4952.430470495867, 4972.7513624318635, 5036.949630503648, 5933.910991335133, 5952.583319167703, 5953.642781433128, 5960.314563825215, 5966.0, 5715.485606295453, 5729.770809167587, 5743.569232307677, 5745.195672605755, 5748.540116790563, 5728.713564321851, 5808.186853840381, 5857.062869940789, 5933.317668468008, 5942.405759424023, 5631.662100273997, 5644.915326270191, 5649.68926709035, 5650.689212093374, 5653.349864765604, 5547.750351234124, 5698.6580805151825, 5708.429157084258, 5762.0, 5762.4525670061275, 5477.917831232615, 5557.666540007613, 5558.305211848519, 5562.694051827189, 5597.384287728265, 5508.779648814003, 5510.063289240758, 5511.173324001272, 5528.834134975958, 5533.889322213614, 5332.520073193431, 5458.372287187024, 5483.287172667528, 5487.6158668892795, 5533.7786488540005, 5488.0, 5541.224228608079, 5563.082091454865, 5570.969370666439, 5576.944230557642, 5364.8122315718765, 5441.782328706808, 5454.372747133972, 5455.509004189642, 5488.231647569263], "unit": "score", "name": "dojo.html", "value": 5258.176142670226}, {"lowerIsBetter": false, "replicates": [512.2188662290007, 545.3564793543618, 549.1488193300384, 553.5765139668152, 553.8338498450464, 34304.82847585762, 35251.82374088132, 35266.8236658817, 35369.64630353696, 35391.2921741565, 40311.0, 40846.59153408465, 40892.59107408925, 40977.59022409775, 41182.0, 8672.653093876253, 8907.77730556738, 8912.197902188802, 8912.8663070054, 8913.153250441197, 8540.957295213515, 8720.651173953034, 8779.95610021949, 8784.341174411913, 8788.0, 8784.736457906272, 8879.467231966071, 8903.37676362655, 8909.242714369286, 8915.465072095694, 8718.302535797122, 8800.427972181787, 8810.955945220298, 8827.646894124227, 8831.823363532694, 8644.48133112009, 8730.563471826383, 8731.650733970633, 8769.736907892773, 8796.604152813139, 38333.0, 38476.42285365722, 38746.80626596877, 38750.612493874985, 38818.80590597057, 3249.723773479257, 3250.6424293327714, 3251.219707270238, 3251.9349613007607, 3262.0, 29134.0, 29313.853430732925, 29383.70616293831, 29645.70354296451, 29848.104556863327, 3496.0735405117666, 3500.7701098027323, 3513.4905438711244, 3579.427291633352, 3617.7829330240006, 249851.0, 249930.0, 251445.0, 252040.0, 252164.0, 49362.0, 50352.74823625859, 55115.724421378436, 55404.78380864801, 55661.721691391285, 60145.398546014854, 61286.69356653188, 61356.0, 61976.38023619796, 62020.689896550226, 13612.863871361358, 13770.173789572658, 13776.586702398945, 13778.586642400744, 13783.173009619455, 10101.898981010243, 10201.336913100773, 10244.334118282288, 10270.691879243635, 10324.277300589038, 18033.54916127081, 18145.546361341072, 18229.54426139357, 18233.27066917335, 18971.33600323982, 7516.586587737617, 7551.244875512514, 7716.189800071024, 7771.378289736807, 7799.571023593757, 967.086103632075, 980.4362491567377, 1021.4994652620163, 1077.5258886090253, 1111.1166622535104, 28887.42225155485, 32039.839800800848, 32048.839755801073, 32098.83950580232, 32216.19459513531, 1072.3244356055634, 1086.125668836594, 1094.5567045346647, 1129.0, 1154.3824054131, 14396.784048239284, 14607.19660418687, 14631.92684036573, 14862.628434289012, 14909.25453727331, 319980.0, 321267.0, 324029.0, 324699.0, 325166.0, 50540.49459505431, 50758.492415076114, 50837.0, 51098.74450627723, 51295.7435212829, 1310.4954592481772, 1328.7408955253634, 1338.4913732781674, 1338.9999999999804, 1340.222670850904, 27724.72275277302, 28277.71722282833, 28368.85815570909, 28401.57397638996, 28677.85661071681, 45317.54682453133, 45815.625531234116, 45884.31173532466, 45915.08169836651, 45926.55550833634, 303366.0, 305174.0, 305384.0, 305809.0, 305823.0, 30521.100495452898, 31068.0, 31392.0, 31865.6813431872, 32120.839395802872, 41277.587224127376, 41377.37933930933, 41729.79135104427, 42225.36661950134, 42400.0, 34428.31143377069, 35071.824640876635, 35233.471497927036, 35298.82350588333, 35760.28479430345, 34742.47886281657, 34888.65111348854, 35074.29851403009, 35336.0, 35411.114722131126, 31638.367232655677, 31990.68009319877, 32019.199520011254, 32139.35721285608, 35752.46371304485, 27784.19026765671, 29893.0, 32075.0, 32161.839190804832, 32223.194420139684, 24246.26943962957, 24811.25566233016, 25099.74900250974, 25111.623325649765, 25301.493970120864], "unit": "score", "name": "ext.html", "value": 18024.29107782101}, {"lowerIsBetter": false, "replicates": [351.7555299067149, 352.59099444644215, 354.72508805675614, 356.82693893461675, 357.15176455917197, 16227.26977286022, 16408.671826563463, 17038.403655872047, 17203.655926881456, 17844.28622855084, 13982.0, 14106.224157671324, 14109.858901410982, 14118.08232464889, 14367.856321436808, 4482.529334419888, 4753.482423006976, 5014.247862820588, 5058.949410505885, 5073.543381095701, 4960.801567937278, 4968.453470118284, 4972.129877271481, 4980.2529620557025, 4982.800687972495, 4859.975700121495, 4953.752312384367, 5049.4698056704065, 5177.559907407875, 5197.740112994354, 4321.330193819963, 5143.408508021588, 5183.81856635016, 5230.189320655286, 5623.493885550321, 5226.608004399685, 5237.266782650432, 5263.526282634543, 5265.552428043621, 5267.394249661262, 12636.431360588796, 12739.490420383174, 20032.79967200324, 20498.18007279707, 20584.27955021582, 2086.9165233390645, 2089.7596776370606, 2155.482684155807, 2180.258712037899, 2244.1584405847807, 9505.287103467199, 9803.362781419257, 9868.90131098687, 11835.585754498552, 12591.622251332476, 1726.180064469367, 1793.2289115680253, 1827.4974382044911, 1841.8250266224686, 1883.0584707646176, 57937.13094303589, 60439.395606043814, 60775.696121519555, 61879.07181392283, 62818.68590657017, 9979.151772099453, 10155.187584993182, 10235.744106397251, 10267.229957753198, 10289.53697083633, 13478.921686265272, 13506.527271545448, 13509.392077356346, 13510.594682159552, 13533.120347177599, 7123.180834204029, 7184.066071410683, 7190.424766018706, 7222.33886206165, 7230.132384113835, 6636.336366363325, 6710.396064354134, 6727.159105111861, 6745.628990405575, 6746.662666866735, 4330.848420305274, 4384.298512238091, 4384.736915784999, 4454.042380888124, 4484.327350897326, 1723.526030341641, 1778.2531336838301, 1850.9352172673891, 1855.4804654696707, 1870.345379117298, 831.8876951611576, 886.499127992682, 985.2069084386994, 1025.323286630835, 1026.14829691356, 16459.83540164607, 16471.83528164703, 16659.25033373501, 16695.91652041732, 16808.57978550546, 908.1871724806393, 909.1090731083575, 917.5228880981851, 967.2310513142069, 984.478226539935, 9459.0, 9609.51952402391, 9627.133557979816, 9658.855117173249, 9883.11052005323, 536284.0, 548235.0, 552149.0, 558983.0, 561717.0, 45141.09717805691, 77781.0, 78591.60704196557, 79883.0, 80868.59565702133, 1068.6847380023066, 1078.0890147825075, 1092.8415379769888, 1109.805783987815, 1115.9721006974892, 14777.408903643734, 14941.701165976403, 15166.165860877758, 15182.392704291704, 15383.0, 32350.029499115066, 32564.674353256163, 33979.15052123618, 35684.28631427409, 37121.443178352885, 43260.35109473298, 43451.130977380904, 43896.0, 44454.77772611116, 45745.77127114476, 9189.908100918905, 9338.813223735351, 9445.338826282094, 9531.285153613646, 9581.329306948446, 11318.660440186808, 11445.599404020819, 11511.712207194887, 14079.507217247758, 17559.561010974317, 12531.49874005066, 13984.860151398356, 14389.208593527457, 14749.410023598935, 14807.925960370128, 14120.78818817698, 14210.78683819723, 14366.13803171813, 14394.568162955127, 14845.183514906352, 14446.638834029234, 14595.781063284272, 14630.122192668474, 14749.483768068067, 14760.778588320969, 9341.392809467363, 9434.81130377375, 9437.81124377495, 9610.375325603813, 9612.279079068958, 10158.0, 10200.540975655966, 12775.425105870072, 13981.720365592428, 14196.929015354857], "unit": "score", "name": "jquery.html", "value": 8578.762225122142}, {"lowerIsBetter": false, "replicates": [1399.517166577531, 1415.964600884978, 1515.3711209847913, 1686.671099135669, 1700.183911722374, 6753.594784312944, 6803.557768745034, 6835.077264569275, 6898.689558969846, 6913.204981427138, 6924.272951340113, 6943.409810166142, 7006.124234470692, 7012.123484564429, 7012.929870701291, 2138.8182004529635, 2163.3834357208198, 2165.317924853674, 2169.566086782642, 2176.336217453676, 2140.1011575138477, 2178.7276590426195, 2188.321620297705, 2189.1462329691353, 2194.2320187934174, 2105.231590469483, 2126.447123747821, 2152.1283880028614, 2156.6010288096754, 2164.5779073080757, 2143.3677065265783, 2176.227439259064, 2199.230269405711, 2206.746224184223, 2218.1238410827714, 2173.4892300309416, 2174.847760656755, 2197.7362716473967, 2198.6372248578964, 2201.4276288165192, 6819.829504262433, 6964.756233531853, 6971.442284617218, 6976.162860456727, 6981.685824137875, 4157.0023194433425, 4225.133847561243, 4233.7883105844585, 4256.36154576816, 4261.87214383569, 2765.4883846488265, 2829.4906916754976, 2843.772498200139, 2849.145256423065, 2863.9427211455863, 936.3539157980971, 940.2149205413488, 941.4915945389481, 954.2652157838426, 974.8391515399951, 8659.26396256319, 8778.780530486725, 8828.117188281185, 8839.867401988975, 8931.598078086501, 3746.194568167857, 3750.6624403803244, 3847.961520384816, 3850.0567360996733, 3872.7676339419727, 7867.173946735625, 7869.606519673994, 7881.0936742274225, 7914.881276780853, 7922.247386498273, 4141.378793181047, 4172.7704976226, 4224.809883555247, 4272.807723652443, 4272.850450234227, 3911.041794760302, 3912.8239229234755, 3920.3335432976464, 3921.3725803871243, 3958.8416463341146, 3270.705636492727, 3272.4109660260906, 3319.1204330852343, 3356.278400143981, 3360.1599600099976, 1062.3148069495132, 1066.8773091094624, 1081.0810810810906, 1094.6114129484079, 1101.0805977009127, 1012.9949350253202, 1017.0, 1116.3692513729716, 1163.139276935079, 1266.7339858629607, 6358.77744278948, 6365.745370185234, 6419.839504012343, 6441.3880681335195, 6446.838829029218, 1091.770728147098, 1100.312304809494, 1128.6049882541045, 1131.6646357298466, 1141.594733869481, 4868.02639472107, 4915.852524424273, 5036.471170527042, 5235.973820130875, 5236.581073514109, 7789.883151752615, 7930.841383172419, 7970.800729981797, 8153.103158652543, 8188.058373287029, 7910.446268761247, 7988.360931125496, 8008.199180081945, 8068.636911339004, 8169.836603267901, 6541.28045914949, 6578.473722102125, 6594.07682924391, 6599.901001484982, 6649.534532582673, 6228.0, 6234.37656234391, 6311.147995020613, 6331.588446750947, 6368.745250189941, 7286.6720997556295, 7308.744193953186, 7378.372838308589, 7394.667239974322, 7405.703771849066, 7680.884786728316, 7694.038245219348, 7713.537187768752, 7743.4966727162555, 7770.417218708732, 5728.971355143198, 5871.970640146772, 5872.471477567039, 5876.706164691663, 5901.734421951109, 6321.33625969285, 6372.6495042773095, 6386.074019267087, 6391.265004524354, 6399.776007839703, 5963.522918166623, 6049.727762250797, 6068.059450785136, 6147.969260153671, 6177.876442471035, 6075.2405949256345, 6092.817215483543, 6095.329513753572, 6197.504199664107, 6222.937770622417, 6142.754289828536, 6161.44546990773, 6165.630062196283, 6169.383061693795, 6180.042093475518, 5748.48263656273, 5766.5675074368755, 5789.131630255327, 5794.667226538004, 5807.216025836627, 5762.337331206797, 5886.028805247258, 5908.172855800105, 5924.0, 5925.377835327401], "unit": "score", "name": "mootools.html", "value": 4057.740245129356}, {"lowerIsBetter": false, "replicates": [335.17379659140215, 335.66768898790195, 340.3822062955734, 341.41106591130296, 349.27873940313253, 6309.0, 6327.873442531147, 6337.936620633793, 6396.296407395189, 6422.775202867901, 6215.782447614334, 6256.436920677138, 6312.431881130698, 6313.810585682425, 6359.20509936258, 4755.0, 4771.403574553172, 4779.784909679072, 4782.234842425212, 4787.449443314029, 4745.952540474603, 4751.287306903975, 4788.353572267752, 4794.089123066607, 4795.664303498756, 4597.632189424855, 4713.245880659095, 4717.457492388385, 4735.266033764755, 4746.572808447239, 4731.929021064687, 4747.786349614258, 4754.334393184957, 4760.238361862085, 4765.404324459442, 4135.738599727082, 4144.274751918432, 4151.294279972381, 4156.9792151039355, 4166.979165104185, 6024.909626355608, 6046.727897244635, 6050.69746512677, 6057.666828324441, 6073.089036644495, 5497.8075767348355, 5576.940381327535, 5587.608867379285, 5591.30108736408, 5598.664080155204, 6692.59844409337, 6694.430973367221, 6710.698018589175, 6712.597244165366, 6722.260551339349, 4600.125976064537, 4613.63090952723, 4620.145273124483, 4630.0508395779125, 4636.976815115937, 6849.760258390932, 7004.579725216452, 7024.964875175642, 7036.0, 7043.119610048744, 4630.490646028934, 4637.1421287062, 4648.395708557933, 4649.535046495391, 4652.185867473178, 4695.107929493453, 4707.129181101507, 4710.52894710533, 4711.246200607955, 4714.198586240347, 5477.534409575231, 5488.725563721798, 5506.146547285097, 5512.145617429224, 5515.117581186991, 6494.707738151795, 6650.20197576294, 6658.90128128863, 6674.032265321501, 6740.865182696417, 1648.1017845274355, 1656.892302000366, 1689.9662006759795, 1690.8055573609192, 1692.0, 1068.5885933915342, 1120.6357933671588, 1132.326265871805, 1137.3403426012892, 1143.7655280667443, 6222.315545290015, 6332.208473940757, 6347.619142851351, 6355.809325720235, 6366.522510811707, 6902.930970690229, 6915.654217289115, 6919.100516932867, 6920.826979325557, 6926.757563485254, 6260.40526150015, 6291.559590828598, 6333.746650134035, 6338.144350512714, 6361.554691171574, 3771.41543060826, 3792.6586607205486, 3799.2021675448464, 3802.6957843372466, 3844.5386553613184, 7351.558906465629, 7352.448566357544, 7354.080739907512, 7356.301151390609, 7356.816079597946, 7045.647717614099, 7188.281171882874, 7197.1363436387965, 7204.423646108299, 7221.350078492961, 7258.0927384076995, 7277.417806575461, 7306.671199796022, 7308.5614863108385, 7320.084989376328, 7059.446921677223, 7061.894071589033, 7065.682044307916, 7067.611281379368, 7076.221615622175, 6776.186857577122, 6922.688479018557, 6952.791416257521, 6985.406240469617, 6990.23107458169, 7289.708411663474, 7299.124105107208, 7304.342609165201, 7311.195768465358, 7324.377427918686, 4616.538346165491, 4638.953610463987, 4647.9767601161775, 4651.86044418668, 4657.46439159501, 6869.896951545631, 6870.793876183722, 6959.408450281783, 7071.398931090915, 7083.787486375417, 6783.728650853911, 6789.456843452611, 6825.761098361533, 6833.282505337067, 6883.827904302432, 6769.796906092825, 6785.219699734594, 6829.180498340231, 6836.179658441019, 6841.350071743176, 6603.80188594343, 6654.334566543307, 6686.398224159849, 6730.528862979741, 6739.427148692416, 6844.657767111724, 6884.483663725341, 6885.242623311332, 6888.311168883272, 6890.827729306808, 6582.0785090086465, 6613.14029176204, 6620.139381880517, 6623.0, 6658.7336506539195], "unit": "score", "name": "prototype.html", "value": 5050.702784686728}, {"lowerIsBetter": false, "replicates": [792.342355844649, 798.3453568074182, 825.1500954017363, 857.794129408942, 869.8999615044272, 13034.73930521389, 13275.867241327584, 13276.402561884726, 13368.131071480348, 13388.531401400953, 13014.609561713163, 13070.346482675852, 13099.083064185486, 13105.934470327635, 13118.868811311884, 814.9633266503007, 818.2431251092745, 832.9875051874227, 834.6953362022879, 839.6473481137906, 820.4707963363627, 822.1408627983772, 822.3256929317962, 827.6565225431439, 829.1998221716043, 869.1308691308691, 873.3057219510473, 873.3973558244822, 873.6112429968666, 873.6549063120063, 869.9347548933823, 871.8299931513326, 872.4547158026234, 873.7160422862531, 874.9956250218772, 640.0910706796313, 642.1940464716797, 643.488426700774, 643.7296335539085, 645.2611759535353, 14052.437902483889, 14143.575692729235, 14148.080374775607, 14160.291985400792, 14168.220747858864, 12222.694432639166, 12244.571439999558, 12426.875731242662, 12454.501819927282, 12813.0, 10169.745756356151, 10364.585416583328, 10364.844527332096, 10365.170786337076, 10716.035556799925, 3564.6435356464144, 3635.314770517644, 3640.9271814563826, 3769.321522126016, 3791.3554695701796, 46649.53350466486, 47026.5297347029, 47202.52797472016, 47534.0, 47612.52387476116, 10203.132733717717, 10223.693289201336, 10228.64199753005, 10343.327683700536, 10404.479776011169, 18608.16263268129, 18897.811021889604, 18918.716219256723, 18940.0, 18968.14643341053, 7690.077190737035, 7797.259260370256, 7865.724699635485, 7871.567063811545, 7921.287084162453, 4513.345564893072, 4521.409767633235, 4582.693932229366, 4643.094596553639, 4644.3265726470145, 2933.1054028521507, 2952.143878275276, 2958.65975412826, 2962.1113665900143, 2971.435427268855, 541.2557733116964, 548.4378512025127, 549.5219159331407, 552.078029690418, 553.2006250967394, 564.7882044233412, 661.715462351184, 665.8335416145964, 667.3620414357727, 684.5892464521247, 7670.160197656851, 7786.883196752054, 7904.130545639975, 8122.228388303101, 8130.918690813134, 501.657349230696, 533.1363191629507, 543.3127094225807, 576.3516044449993, 701.7052837808133, 3643.5081264029545, 3740.9064773380883, 4208.642265407475, 4267.615914567704, 4314.288142456459, 52108.47891521112, 53192.73403632957, 53544.46455535472, 53612.73193634007, 54113.0, 49784.50215497871, 49865.50134498681, 53315.73342133265, 55218.44781552214, 56821.0, 44492.77753611276, 44562.554374456486, 45211.773941130086, 45423.0, 46166.76916615463, 8363.330933525425, 8403.873941890753, 8419.831603367777, 8570.228679418882, 8702.956485217534, 33841.49237761485, 34524.654753452145, 34791.82604086964, 34915.65084349124, 35359.0, 39202.411963821134, 43353.56646433622, 43589.346159808265, 43833.78083109564, 44435.0, 10470.528826202992, 10659.840102398626, 10786.622468213574, 10822.621208257673, 11119.944400277947, 11597.5360985563, 11896.0, 11898.167128300936, 11899.643010709346, 11971.401429928643, 10792.838107428552, 10819.621313253998, 10930.617428389969, 10941.890581094087, 10985.340879546933, 11270.098392128773, 11303.0, 11392.829107563559, 11420.0, 11527.481263343001, 10040.64857729976, 10189.490525473548, 10578.788424231627, 10685.626003089854, 10791.352518848895, 9132.954335228282, 9137.49863700798, 9360.204382627553, 9638.373505722106, 9713.337597952881, 8735.73792786192, 9008.0, 9377.906220937975, 9444.52777361143, 9475.857862132212], "unit": "score", "name": "yui.html", "value": 6260.2966807070825}], "name": "dromaeo_css", "value": 6861.169341077168}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 109.0, 112.0, 112.0, 112.0, 123.0, 112.0, 112.0, 112.0, 114.0], "unit": "score", "name": "ai-astar", "value": 113.0}, {"lowerIsBetter": true, "replicates": [152.0, 133.0, 151.0, 169.0, 126.0, 159.0, 160.0, 132.0, 169.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 148.1}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 161.0, 162.0, 164.0, 160.0, 160.0, 164.0, 170.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.8}, {"lowerIsBetter": true, "replicates": [75.0, 71.0, 75.0, 73.0, 72.0, 72.0, 137.0, 75.0, 72.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 138.0, 95.0, 97.0, 97.0, 147.0, 97.0, 96.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 109.5}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [149.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 148.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 59.0, 60.0, 62.0, 60.0, 61.0, 61.0, 61.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 60.3}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 68.0, 68.0, 68.0, 68.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 88.0, 87.0, 87.0, 88.0, 87.0, 88.0, 87.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.2}, {"lowerIsBetter": true, "replicates": [123.0, 126.0, 119.0, 134.0, 124.0, 118.0, 117.0, 123.0, 122.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.2}, {"lowerIsBetter": true, "replicates": [141.0, 144.0, 150.0, 150.0, 152.0, 148.0, 152.0, 150.0, 155.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.4}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 71.0, 67.0, 68.0, 67.0, 67.0, 69.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1519.6000000000004}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.8335001668335], "unit": "score", "name": "Richards", "value": 211.6001880000001}, {"lowerIsBetter": false, "replicates": [188.7504718761797], "unit": "score", "name": "DeltaBlue", "value": 350.2931640000001}, {"lowerIsBetter": false, "replicates": [282.88543140028287], "unit": "score", "name": "Encrypt", "value": 940.9498350000002}, {"lowerIsBetter": false, "replicates": [5263.1578947368425], "unit": "score", "name": "Decrypt", "value": 50.57439}, {"lowerIsBetter": false, "replicates": [1062.6992561105208], "unit": "score", "name": "RayTrace", "value": 696.3296489999998}, {"lowerIsBetter": false, "replicates": [729.3946024799417], "unit": "score", "name": "Earley", "value": 913.7207730000002}, {"lowerIsBetter": false, "replicates": [12456.79012345679], "unit": "score", "name": "Boyer", "value": 53.501985133795806}, {"lowerIsBetter": false, "replicates": [24951.219512195123], "unit": "score", "name": "RegExp", "value": 36.51064027370476}, {"lowerIsBetter": false, "replicates": [571.1022272986864], "unit": "score", "name": "Splay", "value": 142.690741}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 21386.17609917017}]} 14:19:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21386.18"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1519.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6861.17"}}} 14:19:32 INFO - Return code: 0 14:19:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:19:32 INFO - # TBPL SUCCESS # 14:19:32 INFO - Running post-action listener: _resource_record_post_action 14:19:32 INFO - Running post-run listener: _resource_record_post_run 14:19:33 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 24576; Write bytes: 319328256; Read time: 56; Write time: 158552 14:19:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 536576; Read time: 0; Write time: 64 14:19:33 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 24576; Write bytes: 318791680; Read time: 56; Write time: 158488 14:19:33 INFO - Running post-run listener: _upload_blobber_files 14:19:33 INFO - Blob upload gear active. 14:19:33 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:19:33 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:19:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 14:19:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 14:19:33 INFO - (blobuploader) - INFO - Open directory for files ... 14:19:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:19:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:19:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:19:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:19:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:19:34 INFO - (blobuploader) - INFO - Done attempting. 14:19:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:19:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:19:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:19:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:19:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:19:35 INFO - (blobuploader) - INFO - Done attempting. 14:19:35 INFO - (blobuploader) - INFO - Iteration through files over. 14:19:35 INFO - Return code: 0 14:19:35 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:19:35 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:19:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a1631774e160f6a8f4cca414ce7cadfc724308382eea587cd929b91e948d68e2693659c9d19b14e21122b9b0eae8b3460083e808232c6cba0f45f68f23ef26b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2cb131dc2f85b5a790b375b4aa5199fb645fee6110737d9edc36c856c01751ab3a11ee7800633b4c04127ec99147629e76a04becea748db71bd39725ba75fac3"} 14:19:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:19:35 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:19:35 INFO - Contents: 14:19:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a1631774e160f6a8f4cca414ce7cadfc724308382eea587cd929b91e948d68e2693659c9d19b14e21122b9b0eae8b3460083e808232c6cba0f45f68f23ef26b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2cb131dc2f85b5a790b375b4aa5199fb645fee6110737d9edc36c856c01751ab3a11ee7800633b4c04127ec99147629e76a04becea748db71bd39725ba75fac3"} 14:19:35 INFO - Copying logs to upload dir... 14:19:35 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1268.093608 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-29 14:19:35.514580) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 14:19:35.519857) ========= 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=6ef107882637bc5fc02d78b7000001c2-1451425947.489452-506125225 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/a1631774e160f6a8f4cca414ce7cadfc724308382eea587cd929b91e948d68e2693659c9d19b14e21122b9b0eae8b3460083e808232c6cba0f45f68f23ef26b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2cb131dc2f85b5a790b375b4aa5199fb645fee6110737d9edc36c856c01751ab3a11ee7800633b4c04127ec99147629e76a04becea748db71bd39725ba75fac3"} build_url:https://queue.taskcluster.net/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011476 build_url: 'https://queue.taskcluster.net/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/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/a1631774e160f6a8f4cca414ce7cadfc724308382eea587cd929b91e948d68e2693659c9d19b14e21122b9b0eae8b3460083e808232c6cba0f45f68f23ef26b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2cb131dc2f85b5a790b375b4aa5199fb645fee6110737d9edc36c856c01751ab3a11ee7800633b4c04127ec99147629e76a04becea748db71bd39725ba75fac3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 14:19:35.545447) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 14:19:35.545790) ========= 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=6ef107882637bc5fc02d78b7000001c2-1451425947.489452-506125225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004602 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 14:19:35.628428) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 14:19:35.628764) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 14:19:35.629067) ========= ========= Total master_lag: 0.32 =========