builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1456589116.83 results: success (0) buildid: 20160227053005 builduid: 4b27a134e83b46dbb285fa86af69d8eb revision: fe9a225a5eb94b245ab44ffa52946f4693508495 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-27 08:05:16.826528) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-27 08:05:16.826907) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-27 08:05:16.827218) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1456587746.448507-749278510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009189 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-27 08:05:16.896623) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-27 08:05:16.896967) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-27 08:05:17.022177) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 08:05:17.022447) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1456587746.448507-749278510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004737 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 08:05:17.080626) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-27 08:05:17.080903) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-27 08:05:17.081238) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 08:05:17.081513) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1456587746.448507-749278510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-27 08:05:17-- 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% 226M=0s 2016-02-27 08:05:17 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166919 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 08:05:17.262534) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 08:05:17.262813) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1456587746.448507-749278510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019930 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 08:05:17.315054) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 08:05:17.315380) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fe9a225a5eb94b245ab44ffa52946f4693508495 --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 fe9a225a5eb94b245ab44ffa52946f4693508495 --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=a12cd81e0ef515edd9e0d800000001bb-1456587746.448507-749278510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-27 08:05:18,114 truncating revision to first 12 chars 2016-02-27 08:05:18,114 Setting DEBUG logging. 2016-02-27 08:05:18,114 attempt 1/10 2016-02-27 08:05:18,114 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fe9a225a5eb9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-27 08:05:18,383 unpacking tar archive at: fx-team-fe9a225a5eb9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.577840 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 08:05:17.911097) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-27 08:05:17.911471) ========= echo fe9a225a5eb94b245ab44ffa52946f4693508495 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'fe9a225a5eb94b245ab44ffa52946f4693508495'] 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=a12cd81e0ef515edd9e0d800000001bb-1456587746.448507-749278510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False fe9a225a5eb94b245ab44ffa52946f4693508495 program finished with exit code 0 elapsedTime=0.004484 script_repo_revision: 'fe9a225a5eb94b245ab44ffa52946f4693508495' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-27 08:05:17.966326) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-27 08:05:17.966707) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-27 08:05:17.976389) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-02-27 08:05:17.976658) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1456587746.448507-749278510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:05:18 INFO - MultiFileLogger online at 20160227 08:05:18 in /builds/slave/test-pgo 08:05:18 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 08:05:18 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:05:18 INFO - {'append_to_log': False, 08:05:18 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:05:18 INFO - 'blob_upload_branch': 'Fx-Team', 08:05:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:05:18 INFO - 'branch': 'Fx-Team', 08:05:18 INFO - 'buildbot_json_path': 'buildprops.json', 08:05:18 INFO - 'config_files': ('talos/linux_config.py',), 08:05:18 INFO - 'default_actions': ('clobber', 08:05:18 INFO - 'read-buildbot-config', 08:05:18 INFO - 'download-and-extract', 08:05:18 INFO - 'populate-webroot', 08:05:18 INFO - 'create-virtualenv', 08:05:18 INFO - 'install', 08:05:18 INFO - 'run-tests'), 08:05:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:05:18 INFO - 'download_minidump_stackwalk': True, 08:05:18 INFO - 'download_symbols': 'ondemand', 08:05:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:05:18 INFO - 'tooltool.py': '/tools/tooltool.py', 08:05:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:05:18 INFO - '/tools/misc-python/virtualenv.py')}, 08:05:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:05:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:05:18 INFO - 'installer_path': 'installer.exe', 08:05:18 INFO - 'log_level': 'info', 08:05:18 INFO - 'log_name': 'talos', 08:05:18 INFO - 'log_to_console': True, 08:05:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:05:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:05:18 INFO - 'opt_config_files': (), 08:05:18 INFO - 'pip_index': False, 08:05:18 INFO - 'sps_profile': False, 08:05:18 INFO - 'sps_profile_interval': 0, 08:05:18 INFO - 'suite': 'dromaeojs-e10s', 08:05:18 INFO - 'system_bits': '32', 08:05:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:05:18 INFO - 'title': 'talos-linux64-ix-064', 08:05:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:05:18 INFO - 'use_talos_json': True, 08:05:18 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:05:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:05:18 INFO - 'work_dir': 'build'} 08:05:18 INFO - ##### 08:05:18 INFO - ##### Running clobber step. 08:05:18 INFO - ##### 08:05:18 INFO - Running pre-action listener: _resource_record_pre_action 08:05:18 INFO - Running main action method: clobber 08:05:18 INFO - rmtree: /builds/slave/test-pgo/build 08:05:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:05:19 INFO - Running post-action listener: _resource_record_post_action 08:05:19 INFO - ##### 08:05:19 INFO - ##### Running read-buildbot-config step. 08:05:19 INFO - ##### 08:05:19 INFO - Running pre-action listener: _resource_record_pre_action 08:05:19 INFO - Running main action method: read_buildbot_config 08:05:19 INFO - Using buildbot properties: 08:05:19 INFO - { 08:05:19 INFO - "project": "", 08:05:19 INFO - "product": "firefox", 08:05:19 INFO - "script_repo_revision": "production", 08:05:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:05:19 INFO - "repository": "", 08:05:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:05:19 INFO - "buildid": "20160227053005", 08:05:19 INFO - "pgo_build": "True", 08:05:19 INFO - "basedir": "/builds/slave/test-pgo", 08:05:19 INFO - "buildnumber": 203, 08:05:19 INFO - "slavename": "talos-linux64-ix-064", 08:05:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:05:19 INFO - "platform": "ubuntu64_hw", 08:05:19 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:05:19 INFO - "branch": "fx-team", 08:05:19 INFO - "repo_path": "integration/fx-team", 08:05:19 INFO - "revision": "fe9a225a5eb94b245ab44ffa52946f4693508495", 08:05:19 INFO - "stage_platform": "linux64-pgo", 08:05:19 INFO - "builduid": "4b27a134e83b46dbb285fa86af69d8eb", 08:05:19 INFO - "slavebuilddir": "test" 08:05:19 INFO - } 08:05:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 08:05:19 INFO - Running post-action listener: _resource_record_post_action 08:05:19 INFO - ##### 08:05:19 INFO - ##### Running download-and-extract step. 08:05:19 INFO - ##### 08:05:19 INFO - Running pre-action listener: _resource_record_pre_action 08:05:19 INFO - Running main action method: download_and_extract 08:05:19 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:05: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')]} 08:05:19 INFO - https://queue.taskcluster.net/v1/task/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:05:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/test_packages.json 08:05:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/test_packages.json 08:05:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:05:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:05:25 INFO - Downloaded 1448 bytes. 08:05:25 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:05:25 INFO - Using the following test package requirements: 08:05:25 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:05:25 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:25 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:05:25 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:25 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:05:25 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:25 INFO - u'jsshell-linux-x86_64.zip'], 08:05:25 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:25 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:05:25 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:05:25 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:25 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:05:25 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:25 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:05:25 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:25 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:05:25 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:05:25 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:25 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:05:25 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:05:25 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')]} 08:05:25 INFO - https://queue.taskcluster.net/v1/task/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:05:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:05:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:05:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:05:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:05:28 INFO - Downloaded 23371906 bytes. 08:05:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:05:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 08:05:29 INFO - Return code: 0 08:05:29 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:29 INFO - https://queue.taskcluster.net/v1/task/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:05:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:05:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:05:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:05:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:05:39 INFO - Downloaded 23371906 bytes. 08:05:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:05:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 08:05:40 INFO - Return code: 0 08:05:40 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')]} 08:05:40 INFO - https://queue.taskcluster.net/v1/task/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:05:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:05:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:05:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:05:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:05:41 INFO - Downloaded 10713410 bytes. 08:05:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:05:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 08:05:42 INFO - Return code: 0 08:05: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')]} 08:05:42 INFO - https://queue.taskcluster.net/v1/task/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:05:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:05:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:05:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:05:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:05:43 INFO - Downloaded 56632879 bytes. 08:05:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:05:43 INFO - mkdir: /builds/slave/test-pgo/properties 08:05:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:05:43 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:05:43 INFO - Contents: 08:05:43 INFO - build_url:https://queue.taskcluster.net/v1/task/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:05:44 INFO - Running post-action listener: _resource_record_post_action 08:05:44 INFO - Running post-action listener: set_extra_try_arguments 08:05:44 INFO - ##### 08:05:44 INFO - ##### Running populate-webroot step. 08:05:44 INFO - ##### 08:05:44 INFO - Running pre-action listener: _resource_record_pre_action 08:05:44 INFO - Running main action method: populate_webroot 08:05:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:05:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:05:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:05:44 INFO - '--tppagecycles', 08:05:44 INFO - '7'], 08:05:44 INFO - 'tests': ['tsvgm']}}, 08:05:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:05:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:05:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:05:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:05:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:05:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:05:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:05:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:44 INFO - 'talos_options': ['--e10s'], 08:05:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:05:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:44 INFO - 'tests': ['damp', 'tps']}, 08:05:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:44 INFO - 'talos_options': ['--e10s'], 08:05:44 INFO - 'tests': ['damp', 'tps']}, 08:05:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:05:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:05:44 INFO - 'other': {'tests': ['a11yr', 08:05:44 INFO - 'ts_paint', 08:05:44 INFO - 'tpaint', 08:05:44 INFO - 'sessionrestore', 08:05:44 INFO - 'sessionrestore_no_auto_restore']}, 08:05:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:05:44 INFO - 'tests': ['a11yr', 08:05:44 INFO - 'ts_paint', 08:05:44 INFO - 'tpaint', 08:05:44 INFO - 'sessionrestore', 08:05:44 INFO - 'sessionrestore_no_auto_restore']}, 08:05:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:05:44 INFO - 'tests': ['a11yr', 08:05:44 INFO - 'ts_paint', 08:05:44 INFO - 'tpaint', 08:05:44 INFO - 'sessionrestore', 08:05:44 INFO - 'sessionrestore_no_auto_restore']}, 08:05:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:05:44 INFO - 'tests': ['a11yr', 08:05:44 INFO - 'ts_paint', 08:05:44 INFO - 'tpaint', 08:05:44 INFO - 'sessionrestore', 08:05:44 INFO - 'sessionrestore_no_auto_restore']}, 08:05:44 INFO - 'other_l64': {'tests': ['a11yr', 08:05:44 INFO - 'ts_paint', 08:05:44 INFO - 'tpaint', 08:05:44 INFO - 'sessionrestore', 08:05:44 INFO - 'sessionrestore_no_auto_restore']}, 08:05:44 INFO - 'other_nol64': {'tests': ['a11yr', 08:05:44 INFO - 'ts_paint', 08:05:44 INFO - 'tpaint', 08:05:44 INFO - 'sessionrestore', 08:05:44 INFO - 'sessionrestore_no_auto_restore']}, 08:05:44 INFO - 'svgr': {'tests': ['tsvgx', 08:05:44 INFO - 'tsvgr_opacity', 08:05:44 INFO - 'tart', 08:05:44 INFO - 'tscrollx', 08:05:44 INFO - 'cart']}, 08:05:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:05:44 INFO - 'tests': ['tsvgx', 08:05:44 INFO - 'tsvgr_opacity', 08:05:44 INFO - 'tart', 08:05:44 INFO - 'tscrollx', 08:05:44 INFO - 'cart']}, 08:05:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:44 INFO - 'tests': ['tp5o']}, 08:05:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:44 INFO - 'talos_options': ['--e10s'], 08:05:44 INFO - 'tests': ['tp5o']}, 08:05:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:44 INFO - 'talos_options': ['--xperf_path', 08:05:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:05:44 INFO - 'tests': ['tp5n']}, 08:05:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:44 INFO - 'talos_options': ['--e10s', 08:05:44 INFO - '--xperf_path', 08:05:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:05:44 INFO - 'tests': ['tp5n']}}, 08:05:44 INFO - 'talos.zip': {'path': '', 08:05:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:05:44 INFO - Running post-action listener: _resource_record_post_action 08:05:44 INFO - ##### 08:05:44 INFO - ##### Running create-virtualenv step. 08:05:44 INFO - ##### 08:05:44 INFO - Running pre-action listener: _resource_record_pre_action 08:05:44 INFO - Running main action method: create_virtualenv 08:05:44 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:05:44 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 08:05:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:05:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:05:44 INFO - Using real prefix '/usr' 08:05:44 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:05:44 INFO - Installing distribute.............................................................................................................................................................................................done. 08:05:46 INFO - Installing pip.................done. 08:05:46 INFO - Return code: 0 08:05:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7ff92df79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14db670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156a8c0>, '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 0x156b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156bc50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1456587746.448507-749278510', '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 08:05:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:05:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:05:46 INFO - Using env: {'DISPLAY': ':0', 08:05:46 INFO - 'HOME': '/home/cltbld', 08:05:46 INFO - 'LANG': 'en_US.UTF-8', 08:05:46 INFO - 'LANGUAGE': 'en_US:en', 08:05:46 INFO - 'LOGNAME': 'cltbld', 08:05:46 INFO - 'MAIL': '/var/mail/cltbld', 08:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:46 INFO - 'MOZ_NO_REMOTE': '1', 08:05:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:46 INFO - 'NO_EM_RESTART': '1', 08:05:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:05:46 INFO - 'PWD': '/builds/slave/test-pgo', 08:05:46 INFO - 'SHELL': '/bin/bash', 08:05:46 INFO - 'SHLVL': '1', 08:05:46 INFO - 'TERM': 'linux', 08:05:46 INFO - 'TMOUT': '86400', 08:05:46 INFO - 'USER': 'cltbld', 08:05:46 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1456587746.448507-749278510', 08:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:46 INFO - '_': '/tools/buildbot/bin/python'} 08:05:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:46 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 08:05:46 INFO - Cleaning up... 08:05:46 INFO - Return code: 0 08:05:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7ff92df79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14db670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156a8c0>, '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 0x156b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156bc50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1456587746.448507-749278510', '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 08:05:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:05:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:05:46 INFO - Using env: {'DISPLAY': ':0', 08:05:46 INFO - 'HOME': '/home/cltbld', 08:05:46 INFO - 'LANG': 'en_US.UTF-8', 08:05:46 INFO - 'LANGUAGE': 'en_US:en', 08:05:46 INFO - 'LOGNAME': 'cltbld', 08:05:46 INFO - 'MAIL': '/var/mail/cltbld', 08:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:46 INFO - 'MOZ_NO_REMOTE': '1', 08:05:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:46 INFO - 'NO_EM_RESTART': '1', 08:05:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:05:46 INFO - 'PWD': '/builds/slave/test-pgo', 08:05:46 INFO - 'SHELL': '/bin/bash', 08:05:46 INFO - 'SHLVL': '1', 08:05:46 INFO - 'TERM': 'linux', 08:05:46 INFO - 'TMOUT': '86400', 08:05:46 INFO - 'USER': 'cltbld', 08:05:46 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1456587746.448507-749278510', 08:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:46 INFO - '_': '/tools/buildbot/bin/python'} 08:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:47 INFO - Downloading/unpacking psutil>=0.7.1 08:05:47 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 08:05:47 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 08:05:47 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 08:05:47 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 08:05:47 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 08:05:47 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 08:05:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:05:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:05:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:05:49 INFO - Installing collected packages: psutil 08:05:49 INFO - Running setup.py install for psutil 08:05:49 INFO - building 'psutil._psutil_linux' extension 08:05:49 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 08:05:49 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 08:05:49 INFO - building 'psutil._psutil_posix' extension 08:05:49 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 08:05:49 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 08:05:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:05:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:05:49 INFO - Successfully installed psutil 08:05:49 INFO - Cleaning up... 08:05:49 INFO - Return code: 0 08:05:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:05:49 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')]} 08:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:49 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')]} 08:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7ff92df79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14db670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156a8c0>, '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 0x156b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156bc50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1456587746.448507-749278510', '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 08:05:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:05:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:05:49 INFO - Using env: {'DISPLAY': ':0', 08:05:49 INFO - 'HOME': '/home/cltbld', 08:05:49 INFO - 'LANG': 'en_US.UTF-8', 08:05:49 INFO - 'LANGUAGE': 'en_US:en', 08:05:49 INFO - 'LOGNAME': 'cltbld', 08:05:49 INFO - 'MAIL': '/var/mail/cltbld', 08:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:49 INFO - 'MOZ_NO_REMOTE': '1', 08:05:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:49 INFO - 'NO_EM_RESTART': '1', 08:05:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:05:49 INFO - 'PWD': '/builds/slave/test-pgo', 08:05:49 INFO - 'SHELL': '/bin/bash', 08:05:49 INFO - 'SHLVL': '1', 08:05:49 INFO - 'TERM': 'linux', 08:05:49 INFO - 'TMOUT': '86400', 08:05:49 INFO - 'USER': 'cltbld', 08:05:49 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1456587746.448507-749278510', 08:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:49 INFO - '_': '/tools/buildbot/bin/python'} 08:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:05: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 08:05: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 08:05: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 08:05: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 08:05: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 08:05: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 08:05:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:05:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:05:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:05:51 INFO - Installing collected packages: mozsystemmonitor 08:05:51 INFO - Running setup.py install for mozsystemmonitor 08:05:51 INFO - Successfully installed mozsystemmonitor 08:05:51 INFO - Cleaning up... 08:05:51 INFO - Return code: 0 08:05:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:05: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')]} 08:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05: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')]} 08:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7ff92df79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14db670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156a8c0>, '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 0x156b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156bc50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1456587746.448507-749278510', '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 08:05:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:05:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:05:51 INFO - Using env: {'DISPLAY': ':0', 08:05:51 INFO - 'HOME': '/home/cltbld', 08:05:51 INFO - 'LANG': 'en_US.UTF-8', 08:05:51 INFO - 'LANGUAGE': 'en_US:en', 08:05:51 INFO - 'LOGNAME': 'cltbld', 08:05:51 INFO - 'MAIL': '/var/mail/cltbld', 08:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:51 INFO - 'MOZ_NO_REMOTE': '1', 08:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:51 INFO - 'NO_EM_RESTART': '1', 08:05:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:05:51 INFO - 'PWD': '/builds/slave/test-pgo', 08:05:51 INFO - 'SHELL': '/bin/bash', 08:05:51 INFO - 'SHLVL': '1', 08:05:51 INFO - 'TERM': 'linux', 08:05:51 INFO - 'TMOUT': '86400', 08:05:51 INFO - 'USER': 'cltbld', 08:05:51 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1456587746.448507-749278510', 08:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:51 INFO - '_': '/tools/buildbot/bin/python'} 08:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:52 INFO - Downloading/unpacking blobuploader==1.2.4 08:05:52 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 08:05:52 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 08:05:52 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 08:05:52 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 08:05:52 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 08:05:52 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 08:05:53 INFO - Downloading blobuploader-1.2.4.tar.gz 08:05:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:05:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:05:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:54 INFO - Downloading docopt-0.6.1.tar.gz 08:05:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:05:54 INFO - Installing collected packages: blobuploader, requests, docopt 08:05:54 INFO - Running setup.py install for blobuploader 08:05:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:05:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:05:54 INFO - Running setup.py install for requests 08:05:55 INFO - Running setup.py install for docopt 08:05:55 INFO - Successfully installed blobuploader requests docopt 08:05:55 INFO - Cleaning up... 08:05:55 INFO - Return code: 0 08:05:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7ff92df79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14db670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156a8c0>, '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 0x156b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156bc50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1456587746.448507-749278510', '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 08:05:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 08:05:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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 08:05:55 INFO - Using env: {'DISPLAY': ':0', 08:05:55 INFO - 'HOME': '/home/cltbld', 08:05:55 INFO - 'LANG': 'en_US.UTF-8', 08:05:55 INFO - 'LANGUAGE': 'en_US:en', 08:05:55 INFO - 'LOGNAME': 'cltbld', 08:05:55 INFO - 'MAIL': '/var/mail/cltbld', 08:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:55 INFO - 'MOZ_NO_REMOTE': '1', 08:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:55 INFO - 'NO_EM_RESTART': '1', 08:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:05:55 INFO - 'PWD': '/builds/slave/test-pgo', 08:05:55 INFO - 'SHELL': '/bin/bash', 08:05:55 INFO - 'SHLVL': '1', 08:05:55 INFO - 'TERM': 'linux', 08:05:55 INFO - 'TMOUT': '86400', 08:05:55 INFO - 'USER': 'cltbld', 08:05:55 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1456587746.448507-749278510', 08:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:55 INFO - '_': '/tools/buildbot/bin/python'} 08:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:05:55 INFO - Running setup.py (path:/tmp/pip-Esbt72-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:05:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:05:55 INFO - Running setup.py (path:/tmp/pip-OHskJN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:05:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:05:55 INFO - Running setup.py (path:/tmp/pip-XDx0Mk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:05:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:05:55 INFO - Running setup.py (path:/tmp/pip-0R2sH5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:05:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:05:55 INFO - Running setup.py (path:/tmp/pip-uVVV09-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:05:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:05:55 INFO - Running setup.py (path:/tmp/pip-3K6kPS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:05:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:05:55 INFO - Running setup.py (path:/tmp/pip-yFE3qn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:05:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:05:55 INFO - Running setup.py (path:/tmp/pip-6sFELN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:05:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:05:56 INFO - Running setup.py (path:/tmp/pip-4ybzw8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:05:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:05:56 INFO - Running setup.py (path:/tmp/pip-n6_I3M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:05:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:05:56 INFO - Running setup.py (path:/tmp/pip-neE31U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:05:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:05:56 INFO - Running setup.py (path:/tmp/pip-0VOkCQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:05:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:05:56 INFO - Running setup.py (path:/tmp/pip-Ml_Tlp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:05:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:05:56 INFO - Running setup.py (path:/tmp/pip-2IylC2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:05:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:05:56 INFO - Running setup.py (path:/tmp/pip-GqZwCb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:05:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:05:56 INFO - Running setup.py (path:/tmp/pip-MfWqwQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:05:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:05:56 INFO - Running setup.py (path:/tmp/pip-0uAn5b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:05:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:05:56 INFO - Running setup.py install for manifestparser 08:05:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:05:56 INFO - Running setup.py install for mozcrash 08:05:56 INFO - Running setup.py install for mozdebug 08:05:56 INFO - Running setup.py install for mozdevice 08:05:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:05:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:05:57 INFO - Running setup.py install for mozfile 08:05:57 INFO - Running setup.py install for mozhttpd 08:05:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:05:57 INFO - Running setup.py install for mozinfo 08:05:57 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:05:57 INFO - Running setup.py install for mozInstall 08:05:57 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:05:57 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:05:57 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:05:57 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:05:57 INFO - Running setup.py install for mozleak 08:05:57 INFO - Running setup.py install for mozlog 08:05:57 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:05:57 INFO - Running setup.py install for moznetwork 08:05:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:05:57 INFO - Running setup.py install for mozprocess 08:05:57 INFO - Running setup.py install for mozprofile 08:05:58 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:05:58 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:05:58 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:05:58 INFO - Running setup.py install for mozrunner 08:05:58 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:05:58 INFO - Running setup.py install for mozscreenshot 08:05:58 INFO - Running setup.py install for moztest 08:05:58 INFO - Running setup.py install for mozversion 08:05:58 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:05:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:05:58 INFO - Cleaning up... 08:05:58 INFO - Return code: 0 08:05:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:05: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')]} 08:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05: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')]} 08:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7ff92df79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14db670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156a8c0>, '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 0x156b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156bc50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1456587746.448507-749278510', '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 08:05:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:05:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:05:58 INFO - Using env: {'DISPLAY': ':0', 08:05:58 INFO - 'HOME': '/home/cltbld', 08:05:58 INFO - 'LANG': 'en_US.UTF-8', 08:05:58 INFO - 'LANGUAGE': 'en_US:en', 08:05:58 INFO - 'LOGNAME': 'cltbld', 08:05:58 INFO - 'MAIL': '/var/mail/cltbld', 08:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:58 INFO - 'MOZ_NO_REMOTE': '1', 08:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:58 INFO - 'NO_EM_RESTART': '1', 08:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:05:58 INFO - 'PWD': '/builds/slave/test-pgo', 08:05:58 INFO - 'SHELL': '/bin/bash', 08:05:58 INFO - 'SHLVL': '1', 08:05:58 INFO - 'TERM': 'linux', 08:05:58 INFO - 'TMOUT': '86400', 08:05:58 INFO - 'USER': 'cltbld', 08:05:58 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1456587746.448507-749278510', 08:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:58 INFO - '_': '/tools/buildbot/bin/python'} 08:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:05:58 INFO - Running setup.py (path:/tmp/pip-1iDWnO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:05:58 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)) 08:05:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:05:58 INFO - Running setup.py (path:/tmp/pip-eEN4kE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:05:58 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)) 08:05:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:05:58 INFO - Running setup.py (path:/tmp/pip-Xuk79U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:05:58 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)) 08:05:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:05:58 INFO - Running setup.py (path:/tmp/pip-HQUg6P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:05:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:05:58 INFO - Running setup.py (path:/tmp/pip-ofx11H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:05:59 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)) 08:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:05:59 INFO - Running setup.py (path:/tmp/pip-SrGFOg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:05:59 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)) 08:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:05:59 INFO - Running setup.py (path:/tmp/pip-bLjPb1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:05:59 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)) 08:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:05:59 INFO - Running setup.py (path:/tmp/pip-2J01Cm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:05:59 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)) 08:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:05:59 INFO - Running setup.py (path:/tmp/pip-jA4Dmn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:05:59 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)) 08:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:05:59 INFO - Running setup.py (path:/tmp/pip-wIG_oR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:05:59 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)) 08:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:05:59 INFO - Running setup.py (path:/tmp/pip-12X7iK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:05:59 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)) 08:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:05:59 INFO - Running setup.py (path:/tmp/pip-QHlgv6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:05:59 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)) 08:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:05:59 INFO - Running setup.py (path:/tmp/pip-AopnVg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:05:59 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)) 08:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:05:59 INFO - Running setup.py (path:/tmp/pip-2D396z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:05:59 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)) 08:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:05:59 INFO - Running setup.py (path:/tmp/pip-Bd0Oi7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:05:59 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)) 08:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:05:59 INFO - Running setup.py (path:/tmp/pip-lwSvts-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:05:59 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)) 08:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:05:59 INFO - Running setup.py (path:/tmp/pip-fkPZxu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:05:59 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)) 08:05:59 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)) 08:05:59 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)) 08:05:59 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)) 08:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:05:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:01 INFO - Downloading blessings-1.6.tar.gz 08:06:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:06:01 INFO - Installing collected packages: blessings 08:06:01 INFO - Running setup.py install for blessings 08:06:01 INFO - Successfully installed blessings 08:06:01 INFO - Cleaning up... 08:06:01 INFO - Return code: 0 08:06:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:06:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:06:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:06:02 INFO - Reading from file tmpfile_stdout 08:06:02 INFO - Current package versions: 08:06:02 INFO - argparse == 1.2.1 08:06:02 INFO - blessings == 1.6 08:06:02 INFO - blobuploader == 1.2.4 08:06:02 INFO - docopt == 0.6.1 08:06:02 INFO - manifestparser == 1.1 08:06:02 INFO - mozInstall == 1.12 08:06:02 INFO - mozcrash == 0.16 08:06:02 INFO - mozdebug == 0.1 08:06:02 INFO - mozdevice == 0.48 08:06:02 INFO - mozfile == 1.2 08:06:02 INFO - mozhttpd == 0.7 08:06:02 INFO - mozinfo == 0.9 08:06:02 INFO - mozleak == 0.1 08:06:02 INFO - mozlog == 3.1 08:06:02 INFO - moznetwork == 0.27 08:06:02 INFO - mozprocess == 0.22 08:06:02 INFO - mozprofile == 0.28 08:06:02 INFO - mozrunner == 6.11 08:06:02 INFO - mozscreenshot == 0.1 08:06:02 INFO - mozsystemmonitor == 0.0 08:06:02 INFO - moztest == 0.7 08:06:02 INFO - mozversion == 1.4 08:06:02 INFO - psutil == 3.1.1 08:06:02 INFO - requests == 1.2.3 08:06:02 INFO - wsgiref == 0.1.2 08:06:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7ff92df79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14db670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156a8c0>, '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 0x156b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156bc50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1456587746.448507-749278510', '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 08:06:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:06:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:06:02 INFO - Using env: {'DISPLAY': ':0', 08:06:02 INFO - 'HOME': '/home/cltbld', 08:06:02 INFO - 'LANG': 'en_US.UTF-8', 08:06:02 INFO - 'LANGUAGE': 'en_US:en', 08:06:02 INFO - 'LOGNAME': 'cltbld', 08:06:02 INFO - 'MAIL': '/var/mail/cltbld', 08:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:02 INFO - 'MOZ_NO_REMOTE': '1', 08:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:02 INFO - 'NO_EM_RESTART': '1', 08:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:06:02 INFO - 'PWD': '/builds/slave/test-pgo', 08:06:02 INFO - 'SHELL': '/bin/bash', 08:06:02 INFO - 'SHLVL': '1', 08:06:02 INFO - 'TERM': 'linux', 08:06:02 INFO - 'TMOUT': '86400', 08:06:02 INFO - 'USER': 'cltbld', 08:06:02 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1456587746.448507-749278510', 08:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:02 INFO - '_': '/tools/buildbot/bin/python'} 08:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:02 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)) 08:06:02 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)) 08:06:02 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)) 08:06:02 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)) 08:06:02 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)) 08:06:02 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)) 08:06:02 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)) 08:06:02 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)) 08:06:02 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)) 08:06:02 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)) 08:06:02 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)) 08:06:02 INFO - Cleaning up... 08:06:02 INFO - Return code: 0 08:06:02 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7ff92df79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14db670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156a8c0>, '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 0x156b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156bc50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1456587746.448507-749278510', '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 08:06:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:06:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:06:02 INFO - Using env: {'DISPLAY': ':0', 08:06:02 INFO - 'HOME': '/home/cltbld', 08:06:02 INFO - 'LANG': 'en_US.UTF-8', 08:06:02 INFO - 'LANGUAGE': 'en_US:en', 08:06:02 INFO - 'LOGNAME': 'cltbld', 08:06:02 INFO - 'MAIL': '/var/mail/cltbld', 08:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:02 INFO - 'MOZ_NO_REMOTE': '1', 08:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:02 INFO - 'NO_EM_RESTART': '1', 08:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:06:02 INFO - 'PWD': '/builds/slave/test-pgo', 08:06:02 INFO - 'SHELL': '/bin/bash', 08:06:02 INFO - 'SHLVL': '1', 08:06:02 INFO - 'TERM': 'linux', 08:06:02 INFO - 'TMOUT': '86400', 08:06:02 INFO - 'USER': 'cltbld', 08:06:02 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1456587746.448507-749278510', 08:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:02 INFO - '_': '/tools/buildbot/bin/python'} 08:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:02 INFO - Downloading/unpacking jsonschema 08:06: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 08:06: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 08:06: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 08:06: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 08:06: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 08:06: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 08:06:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:06:04 INFO - Downloading/unpacking functools32 (from jsonschema) 08:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:04 INFO - Downloading functools32-3.2.3-2.tar.gz 08:06:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:06:04 INFO - warning: no files found matching '*.txt' 08:06:04 INFO - no previously-included directories found matching 'build' 08:06:04 INFO - no previously-included directories found matching 'dist' 08:06:04 INFO - no previously-included directories found matching '.git*' 08:06:04 INFO - Installing collected packages: jsonschema, functools32 08:06:04 INFO - Running setup.py install for functools32 08:06:04 INFO - warning: no files found matching '*.txt' 08:06:04 INFO - no previously-included directories found matching 'build' 08:06:04 INFO - no previously-included directories found matching 'dist' 08:06:04 INFO - no previously-included directories found matching '.git*' 08:06:04 INFO - Successfully installed jsonschema functools32 08:06:04 INFO - Cleaning up... 08:06:04 INFO - Return code: 0 08:06:04 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7ff92df79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14db670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156a8c0>, '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 0x156b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156bc50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1456587746.448507-749278510', '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 08:06:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:06:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:06:04 INFO - Using env: {'DISPLAY': ':0', 08:06:04 INFO - 'HOME': '/home/cltbld', 08:06:04 INFO - 'LANG': 'en_US.UTF-8', 08:06:04 INFO - 'LANGUAGE': 'en_US:en', 08:06:04 INFO - 'LOGNAME': 'cltbld', 08:06:04 INFO - 'MAIL': '/var/mail/cltbld', 08:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:04 INFO - 'MOZ_NO_REMOTE': '1', 08:06:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:04 INFO - 'NO_EM_RESTART': '1', 08:06:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:06:04 INFO - 'PWD': '/builds/slave/test-pgo', 08:06:04 INFO - 'SHELL': '/bin/bash', 08:06:04 INFO - 'SHLVL': '1', 08:06:04 INFO - 'TERM': 'linux', 08:06:04 INFO - 'TMOUT': '86400', 08:06:04 INFO - 'USER': 'cltbld', 08:06:04 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1456587746.448507-749278510', 08:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:04 INFO - '_': '/tools/buildbot/bin/python'} 08:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:05 INFO - Downloading/unpacking flake8 08:06:05 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 08:06:05 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 08:06:05 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 08:06:05 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 08:06:05 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 08:06:05 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 08:06:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:06:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:06:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:06:07 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 08:06:07 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 08:06:07 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 08:06:07 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 08:06:07 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 08:06:07 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 08:06:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:06:07 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 08:06:07 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 08:06:07 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 08:06:07 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 08:06:07 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 08:06:07 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 08:06:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:06:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:06:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:06:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:06:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:06:07 INFO - no previously-included directories found matching 'docs/_build' 08:06:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:06:07 INFO - Running setup.py install for pep8 08:06:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:06:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:06:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:06:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:06:07 INFO - no previously-included directories found matching 'docs/_build' 08:06:07 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:06:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:06:07 INFO - Cleaning up... 08:06:07 INFO - Return code: 0 08:06:07 INFO - Running post-action listener: _resource_record_post_action 08:06:07 INFO - Running post-action listener: _start_resource_monitoring 08:06:07 INFO - Starting resource monitoring. 08:06:07 INFO - ##### 08:06:07 INFO - ##### Running install step. 08:06:07 INFO - ##### 08:06:07 INFO - Running pre-action listener: _resource_record_pre_action 08:06:07 INFO - Running main action method: install 08:06:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:06:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:06:08 INFO - Reading from file tmpfile_stdout 08:06:08 INFO - Detecting whether we're running mozinstall >=1.0... 08:06:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:06:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:06:08 INFO - Reading from file tmpfile_stdout 08:06:08 INFO - Output received: 08:06:08 INFO - Usage: mozinstall [options] installer 08:06:08 INFO - Options: 08:06:08 INFO - -h, --help show this help message and exit 08:06:08 INFO - -d DEST, --destination=DEST 08:06:08 INFO - Directory to install application into. [default: 08:06:08 INFO - "/builds/slave/test-pgo"] 08:06:08 INFO - --app=APP Application being installed. [default: firefox] 08:06:08 INFO - mkdir: /builds/slave/test-pgo/build/application 08:06:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 08:06:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 08:06:24 INFO - Reading from file tmpfile_stdout 08:06:24 INFO - Output received: 08:06:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:06:24 INFO - Running post-action listener: _resource_record_post_action 08:06:24 INFO - ##### 08:06:24 INFO - ##### Running run-tests step. 08:06:24 INFO - ##### 08:06:24 INFO - Running pre-action listener: _resource_record_pre_action 08:06:24 INFO - Running main action method: run_tests 08:06:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:06:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:06:24 INFO - Python 2.7.3 08:06:24 INFO - Return code: 0 08:06:24 INFO - grabbing minidump binary from tooltool 08:06:24 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')]} 08:06:24 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 0x156a8c0>, '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 0x156b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156bc50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:06:24 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 08:06:24 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 08:06:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:06:24 INFO - Return code: 0 08:06:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:06:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:06:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:06:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:06:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:06:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:06:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:06:25 INFO - Return code: 0 08:06:25 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/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 08:06:25 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/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 08:06:25 INFO - Using env: {'DISPLAY': ':0', 08:06:25 INFO - 'HOME': '/home/cltbld', 08:06:25 INFO - 'LANG': 'en_US.UTF-8', 08:06:25 INFO - 'LANGUAGE': 'en_US:en', 08:06:25 INFO - 'LOGNAME': 'cltbld', 08:06:25 INFO - 'MAIL': '/var/mail/cltbld', 08:06:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:06:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:25 INFO - 'MOZ_NO_REMOTE': '1', 08:06:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:06:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:25 INFO - 'NO_EM_RESTART': '1', 08:06:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:06:25 INFO - 'PWD': '/builds/slave/test-pgo', 08:06:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:06:25 INFO - 'SHELL': '/bin/bash', 08:06:25 INFO - 'SHLVL': '1', 08:06:25 INFO - 'TERM': 'linux', 08:06:25 INFO - 'TMOUT': '86400', 08:06:25 INFO - 'USER': 'cltbld', 08:06:25 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1456587746.448507-749278510', 08:06:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:25 INFO - '_': '/tools/buildbot/bin/python'} 08:06:25 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/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 08:06:25 INFO - mozversion application_buildid: 20160227053005 08:06:25 INFO - mozversion application_changeset: fe9a225a5eb94b245ab44ffa52946f4693508495 08:06:25 INFO - mozversion application_display_name: Nightly 08:06:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:06:25 INFO - mozversion application_name: Firefox 08:06:25 INFO - mozversion application_remotingname: firefox 08:06:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:06:25 INFO - mozversion application_vendor: Mozilla 08:06:25 INFO - mozversion application_version: 47.0a1 08:06:25 INFO - mozversion platform_buildid: 20160227053005 08:06:25 INFO - mozversion platform_changeset: fe9a225a5eb94b245ab44ffa52946f4693508495 08:06:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:06:25 INFO - mozversion platform_version: 47.0a1 08:06:25 INFO - using testdate: 1456589185 08:06:25 INFO - actual date: 1456589185 08:06:25 INFO - starting webserver on 'localhost:55063' 08:06:25 INFO - SUITE-START | Running 2 tests 08:06:25 INFO - TEST-START | dromaeo_css 08:06:25 INFO - operating with platform_type : linux_ 08:06:25 INFO - Initialising browser for dromaeo_css test... 08:06:25 INFO - TEST-INFO | started process 25986 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJ4ND86/profile http://localhost:55063/getInfo.html) 08:06:29 INFO - PROCESS | 25986 | 08:06:29 INFO - PROCESS | 25986 | (process:26068): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:06:30 INFO - PROCESS | 25986 | __metrics Screen width/height:1600/1200 08:06:30 INFO - PROCESS | 25986 | colorDepth:24 08:06:30 INFO - PROCESS | 25986 | Browser inner width/height: 1024/697 08:06:30 INFO - PROCESS | 25986 | __metrics 08:06:31 ERROR - PROCESS | 25986 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 08:06:31 INFO - PROCESS | 25986 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:06:31 INFO - PROCESS | 25986 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:06:31 INFO - PROCESS | 25986 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:06:31 INFO - PROCESS | 25986 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:06:31 INFO - PROCESS | 25986 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:06:31 INFO - PROCESS | 25986 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:06:31 INFO - PROCESS | 25986 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:06:31 INFO - PROCESS | 25986 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:06:31 INFO - PROCESS | 25986 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:06:32 INFO - TEST-INFO | 25986: exit 0 08:06:32 INFO - Browser initialized. 08:06:32 INFO - Running cycle 1/1 for dromaeo_css test... 08:06:32 INFO - TEST-INFO | started process 26120 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJ4ND86/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:06:33 INFO - PROCESS | 26120 | 08:06:33 INFO - PROCESS | 26120 | (process:26178): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:06:44 INFO - PROCESS | 26120 | RSS: Main: 158240768 08:06:44 INFO - PROCESS | 26120 | 08:07:33 INFO - PROCESS | 26120 | 1456589253663 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] 08:09:42 INFO - PROCESS | 26120 | Cycle 1(1): loaded http://localhost:55063/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55063/tests/dromaeo/cssquery-ext.html) 08:09:43 INFO - PROCESS | 26120 | RSS: Main: 165814272 08:09:43 INFO - PROCESS | 26120 | 08:12:45 INFO - PROCESS | 26120 | Cycle 1(1): loaded http://localhost:55063/tests/dromaeo/cssquery-ext.html (next: http://localhost:55063/tests/dromaeo/cssquery-jquery.html) 08:12:46 INFO - PROCESS | 26120 | RSS: Main: 161812480 08:12:46 INFO - PROCESS | 26120 | 08:15:47 INFO - PROCESS | 26120 | Cycle 1(1): loaded http://localhost:55063/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55063/tests/dromaeo/cssquery-mootools.html) 08:15:48 INFO - PROCESS | 26120 | RSS: Main: 163663872 08:15:48 INFO - PROCESS | 26120 | 08:18:50 INFO - PROCESS | 26120 | Cycle 1(1): loaded http://localhost:55063/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55063/tests/dromaeo/cssquery-prototype.html) 08:18:50 INFO - PROCESS | 26120 | RSS: Main: 162525184 08:18:50 INFO - PROCESS | 26120 | 08:21:53 INFO - PROCESS | 26120 | Cycle 1(1): loaded http://localhost:55063/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55063/tests/dromaeo/cssquery-yui.html) 08:21:53 INFO - PROCESS | 26120 | RSS: Main: 163266560 08:21:53 INFO - PROCESS | 26120 | 08:24:56 INFO - PROCESS | 26120 | Cycle 1(1): loaded http://localhost:55063/tests/dromaeo/cssquery-yui.html (next: http://localhost:55063/tests/dromaeo/cssquery-dojo.html) 08:24:56 INFO - PROCESS | 26120 | RSS: Main: 165748736 08:24:56 INFO - PROCESS | 26120 | 08:24:56 INFO - PROCESS | 26120 | __start_tp_report 08:24:56 INFO - PROCESS | 26120 | _x_x_mozilla_page_load 08:24:56 INFO - PROCESS | 26120 | _x_x_mozilla_page_load_details 08:24:56 INFO - PROCESS | 26120 | |i|pagename|runs| 08:24:56 INFO - PROCESS | 26120 | |0;dojo.html;3186.5379519969606;3208.0536241808663;3248.0742988248326;3253.2192273854275;3259.5925509311337;5225.163973764198;5234.424213336535;5235.947640523594;5256.474352564742;5275.49882761138;5245.396779370373;5294.047071527133;5297.947020529803;5300.708461034651;5307.73461326934;4774.262053498332;4775.426948766144;4787.281907713836;4944.1594928862;4960.751962401883;4778.665493415462;4804.951950480503;4835.516448355154;4861;4889.3888263967;4790.281457781326;4799.9760001199775;4801.831935882262;4813.542713442217;4851.151048566487;4781.139394908915;4784.856454306341;4811.78346974387;4814.518548145193;4852.296417019513;4771.427428708543;4830.227163653799;4841.419029716457;4860.659753817235;4864;5104.770285337168;5136.691798492103;5149.768260428253;5149.819756308549;5177.249298851683;5585.692786896719;5641.971790141064;5643.351014633328;5660.971695141539;5700.686462244575;5639.520640745542;5692.943070569324;5768;5778.104393818965;5867.559933004999;5401.162819762943;5407.783688652488;5416.133418652997;5420.783168673248;5422.240886275925;5836.766529338864;5838.883222335529;5839.766409343579;5848.181254624356;5854.590178687451;5420.620556561003;5600.803971860965;5601.383847776741;5612.803551875665;5654.971725141348;5564.248826408383;5638.323401191801;5650.237217975603;5657.57568182388;5662.094064949588;5634.746436410372;5640.802571909963;5651.858703532363;5666.829995100071;5686.118651609007;5538;5627.099664053813;5642.181883626851;5706.9429305707245;5731.570132240098;4314.395984562164;4320.308750599889;4325.740455572675;4328.372386004012;4358.694891357638;3871.2257548490416;3885.7862817545306;3911.6675082618294;3945.191235796655;3965.266425711253;5365.731713414314;5382.542483888913;5385.649932754437;5408.783648654088;5448.210009548593;5650.915236271459;5656.5757568181725;5665.886682266331;5679.772809087673;5700.458456446631;5341.4925582069645;5350.571954243729;5370.489803468664;5370.597205209625;5408.567314614821;4767.308740232646;4792.592629626451;4795.400574928134;4804.759762011886;4838.661293709477;5820.82537523875;5861.20873682056;5864.67744274069;5892.787049780622;5944.910826337608;5571.303587051619;5586.720663966867;5621.634593751393;5642.548596112383;5667.064934285797;5934.643921364732;5941.9405805943115;5960.314563825215;5979.162917191509;5989.7304621293015;5596.440355964371;5619.859503512282;5630.915536266877;5631.774729010794;5652.5477961762135;5575.080111781511;5636.520895723909;5699.8860022800145;5700.800471983461;5751.482366587027;5410.458954104715;5497.780088796563;5533;5545.279113715191;5573.693446860461;5481.890362192654;5520.171974203741;5536.7785288588;5539.446055394589;5550;5321.574274057989;5356.116240820221;5367.731613419235;5386.757595908115;5411.918821217763;5465.590080744039;5532.778688852401;5626.634268772516;5631.605787594829;5683.9715801420725;5448.673079615236;5457.508824205841;5465.234867118686;5471.124620060771;5489.917651235314 08:24:56 INFO - PROCESS | 26120 | |1;ext.html;521.5879455230371;544.0805039483275;547.2693953571982;554.0857584984777;572.768028948276;35505.64494355056;36135;36361.09097272566;36466.63533364666;36492.81753591232;40099.59900400995;41075.79462102693;41114.38328425076;41205.58794412055;41355.37966930499;8534.87197692035;8588.828223435528;8673.479591224515;8740.125987401241;8751.73099900514;8488.53313067781;8581.52801595912;8586.742397728047;8629.266512346427;8641.13588641134;8610.913890861073;8619.784505387384;8650.43772154811;8728.912710872904;8730.214280714734;8550.2732267757;8591.05498395176;8661.437006594582;8678.566071696421;8692.174243446863;8545.57272136397;8676.175763302475;8712.21590056898;8734.606942687531;8749.47503149813;37404.43893341602;37804;37822.81088594539;37861.43207851885;37880.242395151945;3460.532828068204;3536.717062634983;3558.3594952908466;3633.400488919325;4045.7370270932297;29342.853285733647;29518.70481295181;29972.03766192979;30249.395012099856;31091.844540777376;3692.390755525362;3753;3760.2479504099288;3841.1741475582603;3844.1735026969054;281232.75068997423;282421;283117;283200;283897;45659.771701141945;59027.81944361175;59753.701231493564;59939.40060599338;60071.39928600746;43868.56131438709;44156.3376549352;44247.77876110599;44345.55654443479;44367.55632443699;15035.473758418402;15061;15084.396624135132;15107.39570417193;15232.3907043717;12156.331401772988;12163.209391389531;12202.511899523919;12216.083793715507;12247.203931744409;14379.496717615042;14386.568402947929;14536.636584085483;14539.636509087146;14646.780298295535;5846.386129456431;5893.793717219963;5907.172995780594;5919.467247947619;5976.312724036705;1007.5768177365524;1056.5034433816095;1064.0264158295074;1065.6183430033868;1088.455772113943;28911.855440722662;29042.27394315159;29272;29552;29592.852035739685;1088.3034857691084;1089.1559041742555;1103.5585765693786;1105.3533682795655;1176.6293617510457;14711.779323310158;15300.846991530165;15302.617434564225;15313.540593782205;15323.693526129638;316294;317218;320355;321596;322083;52210.21684674733;53650.73174634102;53842.73078634582;53928.730356347965;53936.46063539393;1306.2162702378687;1325.1982550556968;1332.9600111996656;1339.9531016414574;1344.717609302038;27887;28173.57739633866;28651.5702264462;29334.26664333409;29376;47251;47469.52530474651;47791.283130752374;47862;47919;297591;298787;299209;299427;299456;32347.676523234466;32450.513242301855;32709.509357359184;32906.17734556655;32986.34027319488;44827.327590086825;45115.54884451245;45243.09513809771;45523.77238113788;45786.54213457956;36894.44658330181;37436;37450;37956.62043379531;38110.23779524338;37224.81387593045;37706.8114659425;37743;38412.23175536418;38412.42381364226;36675.633243667224;37201;37255.441168381956;37737.62262377341;38280.42579361256;32531.349373011933;33751.19865750375;34211.4868276981;34701.652983469845;34783.652163478044;25333.61999569971;25469.3632659185;25861.741382585933;26000.8699956499;26168.8691556541 08:24:56 INFO - PROCESS | 26120 | |2;jquery.html;353.4256832646948;353.60219752778124;355.9430491121421;357.3817296077787;363.07959323115904;16835.494935151935;16918.49244522663;17350.82649173508;17396.826031739678;17424.651506969854;16035.518934431957;16185.19074046299;16953.152342382895;16968.915155424238;16995.790547228873;5103.770330335125;5337.733113344337;5479.424660410659;5491;5513.669179849222;5422.15956526739;5457.727113644321;5478.178273259023;5491;5497.615166938296;4842.055799119174;5006.599472042228;5048.242763585473;5442.183672449125;5447.863803404907;4935.432425271104;4980.576650984689;4981.178105612569;4983.551480366767;5041.218611115265;4816.85549433514;4835.516448355136;4847.418309802846;4848.903021939576;4932.704037757746;12213.328266945315;12469.501219951191;13201.669958251025;20135.597288054156;20211.595768084702;2091.1217288738767;2121.7984291492285;2271.693321401606;2554.846709197454;2737.0283549340097;9247.768805779842;9307.488088155149;9631.518424078839;10980;12803.231806091571;1748.9912550437293;1818.299954517507;1821.772278465192;1846.1230915315252;1891.2435025989578;61601.513868831054;64263;64844.351556484304;65722.67138664276;66930.99603506;9367.672131475365;9477.24182065447;9548.952255238679;9691.612335506501;9715.902840971641;12317;12461.1900226485;12469;12486.75026499465;12498.687532811753;7126.928730712731;7217.06178196831;7272.8181795454475;7336.816579585553;7368.336849683555;7129.714811407589;7217.92782072183;7221.53060051095;7229.49393542447;7305.196428392873;4148.668106551469;4155.854545090907;4161.583841615814;4176.206520761046;4177.749335039907;1745.9650806984043;1777.4845294864604;1789.2753434858903;1796.2725096336005;1846.6306738652324;886.8935727712716;914.29599208609;929.8047410043831;997.670768646345;1024.9231307651955;15736.449224277096;16086.276117574736;16243.02541847493;16575.336986520404;16728.079955602316;929.2426672262085;946.5172761891484;958.0993865766158;960.2078285414561;976.5215044628081;9132.132447417485;9444.433333999981;9453.385529940531;9498.430094194371;9591;446367;462044;466741;468099;469063;71076;72054.63972680103;74246.62876685582;74325;74676;996.6661168508631;997.2520609542843;1000.7097941596855;1002.8245057114975;1013.8175128476797;14373;14542.200178990257;14608;14742.2628868554;14935.775963360342;24135.879320603286;28098.71901280961;31315.217119572193;33105.83447082749;34984.47523287102;43090.353644694726;43594.56405436032;44219.55780442154;44445.33332000087;44761.32858007067;7633.923660763543;7730.7680769577;7792.7142021565805;7913.406494512819;7984.6806127754235;11724.58963936258;12121.939390302992;12409.255444673348;12699.111062225926;12857.100003000074;10909;10941.507632156732;11053.502592383202;11095.16786241019;11212;10771.730706732395;10942.781144377228;11251.7749645005;11274.154438416988;11274.549018039186;10620.150387969099;11112.722181945515;11145.609903653332;11231.831522527005;11362.829557556477;7781.844363112593;7783.377329813715;7898.802529936797;7918.643661035152;7976.481528700616;10171.084602385821;10276.743081422725;10314.381137131797;10399.688009359428;10571.62999295021 08:24:56 INFO - PROCESS | 26120 | |3;mootools.html;1462.678210793625;1484.027961685096;1674.7320428731405;1792.9282828686853;1844.8247416495437;7548.169701332849;7567.508111972725;7708.961455192723;7741.458097933147;7742.8451430971345;7678.731244406447;7716.189800070996;7752.844943101135;7758.379329653629;7809.258120478559;2251.5046689728274;2277.829162812787;2284.680144779732;2286.862788232703;2289.107248173214;2250.122452243618;2288.473651060249;2289.7366802817637;2290.3129061281634;2292.495650956787;2260.8982595783227;2261.7398999115067;2262.332611879491;2281;2283.771622837711;2274.8748818814956;2285.0517035430275;2290.083966413448;2294.8623082615013;2300.1374484568205;2208.149862303009;2215.878126703031;2221.0893533651288;2223.7665045170347;2228.398332450229;7689.961550192269;7732.613369331567;7735.226477352276;7766.57283849388;7779.33875620573;4483.596476317114;4605.009922866566;4636;4639.512851150648;4639.837605683819;2987.14866263114;3018.8490575471137;3124.297033167542;3130.624325080982;3175.1903264667594;1038.6520515627274;1043.519980808829;1790.8477779388768;1864.44998725375;1900.7719073711105;10207.591696332138;10243.487825608765;10307.690769276935;10336.379817210916;10348.120409765179;3829.0810205550465;3909;3956.643902048829;3987.182627561343;4001.8799436016966;8185.386096042821;8229.95885020583;8231.42380033392;8236.958815206006;8270.958645206736;4625.1443482955765;4639.768011599406;4639.884002899887;4643.605293550086;4659.068186362673;4162.875113746592;4243.5119961204855;4256.106217694257;4264.168487144977;4287.506936702257;3230.7415406767873;3325.251818340854;3334.333133373335;3341.3818443588016;3343.8160901150673;991.2367477042781;993.1657407777501;1000.9249306302056;1001.4892404873567;1002.3284399452384;1322.3190057120592;1328.2561765411401;1336.7059246965653;1352.8376594808685;1363.236587510997;7302.087239095114;7317.817054573678;7318.194998550155;7365.594892280868;7376.594287314249;436.79907242668094;443.94895582409475;446.65607482238494;1216.5133946421502;1241.782688029591;5720.913026524947;5785.508231800344;5806.883862322815;5868.794592189253;5898;9205.079492050741;9469.053094690476;9507;9522.143007129253;9525.809483810284;8610.612522436506;8757.60590773404;9237.399569027992;9338.393004454825;9370.953145234367;6939.271376505495;7020.508564400443;7031.824204394931;7046.084009078787;7148;7104.680289386886;7229.819254518679;7281.089863767029;7291.963540182265;7343.926560734324;8115.350771938349;8214.753557393287;8244.051934027424;8303.709370172015;8448.324134069382;8287;8402.41183117176;8546.700865469678;8637.438566493158;8651.394402391772;6590.110335104891;6885.070515480346;7525;7544.170141284345;7587.772366829004;7103.360697537247;7117.501774875709;7155.463340249398;7172.318629730167;7180.030695855992;6447.806565803034;6515.837104072247;6570.080188773671;6691.732330706717;6701.128853249046;6477.708503117466;6486.805395838132;6520.510961677988;6601.273859875506;6606.10817539626;6389.2971773105855;6472.288048314587;6491.123698300669;6587.110740050223;6611.537192396486;6216.658083805253;6360.332165122781;6399.520035997412;6400.647964362005;6424.4860411166055;6387.968060159856;6456.2575303838785;6471.838204044937;6516.218053833571;6521.315261897433 08:24:56 INFO - PROCESS | 26120 | |4;prototype.html;318.4061724883094;318.5333486442361;321.5915786950574;324.38205219057676;327.1624640919246;6125.754969801208;6247;6300.275468321144;6301.842453938654;6313.810585682425;6105.847353816157;6185.6597887116195;6188.566800323979;6190.226221722285;6198.504119670427;4538.183127037132;4634.86095417138;4669.836555720551;4722.763861806896;4745.928811067828;4644.396228490292;4667.6965997210245;4675.696079754805;4683.578477936985;4732.526747325274;4621.399218101642;4628.1669299526075;4650.7442090685;4651.581357677808;4669.463011753641;4655.650826188033;4657.138429390574;4659.650526210531;4675.976620116878;4680.227762419197;4035.717499775017;4045.393191021341;4045.554988951213;4048.3522636378334;4052.716309858311;5848.093545500455;5867.325257595346;5892.558058145613;5904.881902361972;5910.320313163998;5161.458046905059;5247.816326428557;5273.525382715574;5333.4399888011585;5395.541378982752;6537.934620653828;6555.246146693144;6555.967220163869;6568.343165683441;6584.111144995412;4324;4328.177646247234;4339.566043395666;4344.261475549164;4353.6299414549485;6780.864382712318;6856.760013399507;6876;6884.139482564679;6936.583804971718;4533.591976722111;4546.29532422475;4546.704464209815;4548.204064288736;4557.430321209848;4510.233260345749;4529.139463501924;4594.770261486912;4607.470140933836;4625.768711564476;5368.651037682538;5395.325584301962;5402.297701298885;5408.161734931092;5419.3225846769155;6620.106285651472;6643.1031810704935;6666.766663166766;6674.833129171712;6680.265170831205;1597.7603359496168;1628.3893539922528;1632.208378936215;1636.4354297767488;1638.9672206555801;1016.8118898003893;1023.3194925374692;1026.8870424253325;1058.8305871060593;1083.5178345636116;6247.531435142382;6270.714503526766;6272.247330320391;6289.496840252768;6320.083587879732;6738.764143254963;6810.795676129724;6815;6815.045893574904;6817.829554261084;6204.100405441186;6291.552942823177;6292.905606415908;6376.681165941777;6398.328175541595;3706.5737440194184;3717.925641487155;3730.5709843367817;3734.514513113278;3747.8126093695205;7245.130584329809;7251.74618888347;7254.600996945219;7260.092488438945;7270.745523906638;7066.858662826715;7067.151941766918;7072.787816365517;7078.433725301964;7081.291870812981;7159.427245820426;7289.817754556178;7313.853722925512;7343;7381.224971378036;6847.48643851723;6856.794296171123;6858.862822743617;6864.176298844171;6889.173299204128;6783.287754785676;6785.117934668461;6787.592744435349;6795.150606174228;6817.318268173143;7276.927230727625;7279.017332660023;7325.743598974011;7341.632918353954;7347.448941329529;4516.954830451785;4575.359449676981;4623;4641.675082744176;4642.53574642533;6849;6876.724931002704;6877.415419689382;6890.965545172242;6918.792436226921;6585.374389432996;6646.833829154117;6662.900056499059;6686.765963191265;6686.765963191265;6603.636799976048;6638.302978187414;6653.068570400051;6654.866902661823;6661.16735408074;6302.873942521215;6427.260865000585;6440.967795160994;6457.644829534421;6488.837779055561;6657.800265992028;6727.596344219362;6730.629815360202;6734.3602357775935;6751.729930802713;6473.320301368289;6524.086627872007;6524.412802847766;6529.216494020558;6534.705938232696 08:24:56 INFO - PROCESS | 26120 | |5;yui.html;741.1328745367919;778.7430148051144;800.2157885272433;836.1429534726905;837.0917554453417;13352.732945341088;13642.795358069638;13644.931775341109;13663;13663.385147668354;13278.33608319585;15058.924705376485;15090.09459432432;15199.772003419957;15221;847.2798121596655;854.3122786157141;856.6830272799042;859.6303589456531;862.9611667474978;695.4123765418238;842.3808500751942;847.3560094328324;853.3727710133047;856.4347530629785;885.5483703311294;887.0685779931079;888.6090120347059;888.844452220862;892.4957399069538;869.5174178331024;876.9386142969995;881.9029906710257;882.298572634757;882.8543290357115;653.1574269192736;654.5058480846977;655.577152736487;655.6295692933477;657.2211928864311;14705.411783528752;14758.188299643516;14758.778618320734;14788;14789.778153327708;12702.364881755875;12762;12798.296093714842;12877.484900604059;12929.288889111094;10754.623588174454;10776.78446431075;10853.837192442119;10921.617743378943;10956.233063685546;3543.6456354364614;3561.1809283864595;3586.605473397924;3615.8011309377976;3633.1098880774116;53465.93068138654;53652.46347536513;53794.73102634462;53933.460665393235;54247.45752542464;9957.352772069793;10110.191184705352;10112.191024718006;10206;10279.331843430153;18130.274789008556;18192.636147277244;18215.544611384557;18222.63554728898;18301;7463.290987356192;7570.886436703454;7716.112647045549;7766.456348055582;7799.454038217384;4411.1618792429335;4486.528914463999;4488.820447182142;4552.362669226311;4584.3352713856975;3133.451645961993;3137.7803553751473;3164.47786115293;3164.604424446944;3170.1916011416943;549.3353042818235;554.1715135871897;557.5010365722655;560.3332034878482;564.8870225954826;586.9765209391577;649.302000349626;656.3993945539873;693.1093544794915;708.7731925783803;7965.4822436541435;8362.247397734232;8432.915670843337;8499;8675.609597568124;586.7770247306082;660.072597999811;690.5718454558106;703.802935178151;716.781381678593;3911.882643520699;3936.3701807710627;3972.9205415892097;4072.775997320176;4167.1457351243525;56439.71780141073;58888.70555647194;58997;59020.704896476105;59282.11076833851;52493;52685.73657131766;52872.20691689628;54053.72973135109;54625.45374546283;46975;47329.29006064912;47591.76204119027;47673.28490072652;51800.48199518032;9033.457992520469;9049.140331668481;9057.864132037894;9158.221551168226;9159.129882661136;35482.645173547935;35577.46633800443;35783.28433431369;35916.28167436584;35958.28083438264;40632.390514142906;41041;41836.58163418327;43887.34168987404;44600;11036.613718519813;11066.833997489883;11268;11361.43192840338;11364.772704545698;11871.244421173154;12147.75704485923;12204.572839950559;12359.505619775467;12750.553730619384;11615.709607259887;12003.459844306852;12063.638090857288;12280.877191227974;12457.875421245672;11641.53433862636;11849.170558060852;11868.76262474763;12009.519619215134;12271.202371845802;11402.543898243977;11822.527098915947;11924.165308428326;12106.576269830513;12273.509059637514;9961.701148965543;10141.746456338651;10217.489125543842;10297.12474439681;10525.684229473129;9246.167844893991;9686.70939871805;10056.98330107078;10428.322159059637;10460.581576736846 08:24:56 INFO - PROCESS | 26120 | __end_tp_report 08:24:56 INFO - PROCESS | 26120 | __start_cc_report 08:24:56 INFO - PROCESS | 26120 | _x_x_mozilla_cycle_collect,306 08:24:56 INFO - PROCESS | 26120 | __end_cc_report 08:24:56 INFO - PROCESS | 26120 | __startTimestamp1456590296374__endTimestamp 08:24:56 INFO - PROCESS | 26120 | 08:24:56 INFO - PROCESS | 26120 | ------- Summary: start ------- 08:24:56 INFO - PROCESS | 26120 | Number of tests: 6 08:24:56 INFO - PROCESS | 26120 | 08:24:56 INFO - PROCESS | 26120 | [#0] dojo.html Cycles:165 Average:5270.15 Median:5448.67 stddev:581.96 (10.7%) stddev-sans-first:560.32 08:24:56 INFO - PROCESS | 26120 | Values: 3186.5 3208.1 3248.1 3253.2 3259.6 5225.2 5234.4 5235.9 5256.5 5275.5 5245.4 5294.0 5297.9 5300.7 5307.7 4774.3 4775.4 4787.3 4944.2 4960.8 4778.7 4805.0 4835.5 4861.0 4889.4 4790.3 4800.0 4801.8 4813.5 4851.2 4781.1 4784.9 4811.8 4814.5 4852.3 4771.4 4830.2 4841.4 4860.7 4864.0 5104.8 5136.7 5149.8 5149.8 5177.2 5585.7 5642.0 5643.4 5661.0 5700.7 5639.5 5692.9 5768.0 5778.1 5867.6 5401.2 5407.8 5416.1 5420.8 5422.2 5836.8 5838.9 5839.8 5848.2 5854.6 5420.6 5600.8 5601.4 5612.8 5655.0 5564.2 5638.3 5650.2 5657.6 5662.1 5634.7 5640.8 5651.9 5666.8 5686.1 5538.0 5627.1 5642.2 5706.9 5731.6 4314.4 4320.3 4325.7 4328.4 4358.7 3871.2 3885.8 3911.7 3945.2 3965.3 5365.7 5382.5 5385.6 5408.8 5448.2 5650.9 5656.6 5665.9 5679.8 5700.5 5341.5 5350.6 5370.5 5370.6 5408.6 4767.3 4792.6 4795.4 4804.8 4838.7 5820.8 5861.2 5864.7 5892.8 5944.9 5571.3 5586.7 5621.6 5642.5 5667.1 5934.6 5941.9 5960.3 5979.2 5989.7 5596.4 5619.9 5630.9 5631.8 5652.5 5575.1 5636.5 5699.9 5700.8 5751.5 5410.5 5497.8 5533.0 5545.3 5573.7 5481.9 5520.2 5536.8 5539.4 5550.0 5321.6 5356.1 5367.7 5386.8 5411.9 5465.6 5532.8 5626.6 5631.6 5684.0 5448.7 5457.5 5465.2 5471.1 5489.9 08:24:56 INFO - PROCESS | 26120 | 08:24:56 INFO - PROCESS | 26120 | [#1] ext.html Cycles:180 Average:46516.34 Median:20293.42 stddev:78622.67 (387.4%) stddev-sans-first:78767.38 08:24:56 INFO - PROCESS | 26120 | Values: 521.6 544.1 547.3 554.1 572.8 35505.6 36135.0 36361.1 36466.6 36492.8 40099.6 41075.8 41114.4 41205.6 41355.4 8534.9 8588.8 8673.5 8740.1 8751.7 8488.5 8581.5 8586.7 8629.3 8641.1 8610.9 8619.8 8650.4 8728.9 8730.2 8550.3 8591.1 8661.4 8678.6 8692.2 8545.6 8676.2 8712.2 8734.6 8749.5 37404.4 37804.0 37822.8 37861.4 37880.2 3460.5 3536.7 3558.4 3633.4 4045.7 29342.9 29518.7 29972.0 30249.4 31091.8 3692.4 3753.0 3760.2 3841.2 3844.2 281232.8 282421.0 283117.0 283200.0 283897.0 45659.8 59027.8 59753.7 59939.4 60071.4 43868.6 44156.3 44247.8 44345.6 44367.6 15035.5 15061.0 15084.4 15107.4 15232.4 12156.3 12163.2 12202.5 12216.1 12247.2 14379.5 14386.6 14536.6 14539.6 14646.8 5846.4 5893.8 5907.2 5919.5 5976.3 1007.6 1056.5 1064.0 1065.6 1088.5 28911.9 29042.3 29272.0 29552.0 29592.9 1088.3 1089.2 1103.6 1105.4 1176.6 14711.8 15300.8 15302.6 15313.5 15323.7 316294.0 317218.0 320355.0 321596.0 322083.0 52210.2 53650.7 53842.7 53928.7 53936.5 1306.2 1325.2 1333.0 1340.0 1344.7 27887.0 28173.6 28651.6 29334.3 29376.0 47251.0 47469.5 47791.3 47862.0 47919.0 297591.0 298787.0 299209.0 299427.0 299456.0 32347.7 32450.5 32709.5 32906.2 32986.3 44827.3 45115.5 45243.1 45523.8 45786.5 36894.4 37436.0 37450.0 37956.6 38110.2 37224.8 37706.8 37743.0 38412.2 38412.4 36675.6 37201.0 37255.4 37737.6 38280.4 32531.3 33751.2 34211.5 34701.7 34783.7 25333.6 25469.4 25861.7 26000.9 26168.9 08:24:56 INFO - PROCESS | 26120 | 08:24:56 INFO - PROCESS | 26120 | [#2] jquery.html Cycles:180 Average:25620.23 Median:23634.05 stddev:75767.95 (320.6%) stddev-sans-first:75956.74 08:24:56 INFO - PROCESS | 26120 | Values: 353.4 353.6 355.9 357.4 363.1 16835.5 16918.5 17350.8 17396.8 17424.7 16035.5 16185.2 16953.2 16968.9 16995.8 5103.8 5337.7 5479.4 5491.0 5513.7 5422.2 5457.7 5478.2 5491.0 5497.6 4842.1 5006.6 5048.2 5442.2 5447.9 4935.4 4980.6 4981.2 4983.6 5041.2 4816.9 4835.5 4847.4 4848.9 4932.7 12213.3 12469.5 13201.7 20135.6 20211.6 2091.1 2121.8 2271.7 2554.8 2737.0 9247.8 9307.5 9631.5 10980.0 12803.2 1749.0 1818.3 1821.8 1846.1 1891.2 61601.5 64263.0 64844.4 65722.7 66931.0 9367.7 9477.2 9549.0 9691.6 9715.9 12317.0 12461.2 12469.0 12486.8 12498.7 7126.9 7217.1 7272.8 7336.8 7368.3 7129.7 7217.9 7221.5 7229.5 7305.2 4148.7 4155.9 4161.6 4176.2 4177.7 1746.0 1777.5 1789.3 1796.3 1846.6 886.9 914.3 929.8 997.7 1024.9 15736.4 16086.3 16243.0 16575.3 16728.1 929.2 946.5 958.1 960.2 976.5 9132.1 9444.4 9453.4 9498.4 9591.0 446367.0 462044.0 466741.0 468099.0 469063.0 71076.0 72054.6 74246.6 74325.0 74676.0 996.7 997.3 1000.7 1002.8 1013.8 14373.0 14542.2 14608.0 14742.3 14935.8 24135.9 28098.7 31315.2 33105.8 34984.5 43090.4 43594.6 44219.6 44445.3 44761.3 7633.9 7730.8 7792.7 7913.4 7984.7 11724.6 12121.9 12409.3 12699.1 12857.1 10909.0 10941.5 11053.5 11095.2 11212.0 10771.7 10942.8 11251.8 11274.2 11274.5 10620.2 11112.7 11145.6 11231.8 11362.8 7781.8 7783.4 7898.8 7918.6 7976.5 10171.1 10276.7 10314.4 10399.7 10571.6 08:24:56 INFO - PROCESS | 26120 | 08:24:56 INFO - PROCESS | 26120 | [#3] mootools.html Cycles:180 Average:5351.64 Median:6388.63 stddev:2739.07 (42.9%) stddev-sans-first:2731.16 08:24:56 INFO - PROCESS | 26120 | Values: 1462.7 1484.0 1674.7 1792.9 1844.8 7548.2 7567.5 7709.0 7741.5 7742.8 7678.7 7716.2 7752.8 7758.4 7809.3 2251.5 2277.8 2284.7 2286.9 2289.1 2250.1 2288.5 2289.7 2290.3 2292.5 2260.9 2261.7 2262.3 2281.0 2283.8 2274.9 2285.1 2290.1 2294.9 2300.1 2208.1 2215.9 2221.1 2223.8 2228.4 7690.0 7732.6 7735.2 7766.6 7779.3 4483.6 4605.0 4636.0 4639.5 4639.8 2987.1 3018.8 3124.3 3130.6 3175.2 1038.7 1043.5 1790.8 1864.4 1900.8 10207.6 10243.5 10307.7 10336.4 10348.1 3829.1 3909.0 3956.6 3987.2 4001.9 8185.4 8230.0 8231.4 8237.0 8271.0 4625.1 4639.8 4639.9 4643.6 4659.1 4162.9 4243.5 4256.1 4264.2 4287.5 3230.7 3325.3 3334.3 3341.4 3343.8 991.2 993.2 1000.9 1001.5 1002.3 1322.3 1328.3 1336.7 1352.8 1363.2 7302.1 7317.8 7318.2 7365.6 7376.6 436.8 443.9 446.7 1216.5 1241.8 5720.9 5785.5 5806.9 5868.8 5898.0 9205.1 9469.1 9507.0 9522.1 9525.8 8610.6 8757.6 9237.4 9338.4 9371.0 6939.3 7020.5 7031.8 7046.1 7148.0 7104.7 7229.8 7281.1 7292.0 7343.9 8115.4 8214.8 8244.1 8303.7 8448.3 8287.0 8402.4 8546.7 8637.4 8651.4 6590.1 6885.1 7525.0 7544.2 7587.8 7103.4 7117.5 7155.5 7172.3 7180.0 6447.8 6515.8 6570.1 6691.7 6701.1 6477.7 6486.8 6520.5 6601.3 6606.1 6389.3 6472.3 6491.1 6587.1 6611.5 6216.7 6360.3 6399.5 6400.6 6424.5 6388.0 6456.3 6471.8 6516.2 6521.3 08:24:56 INFO - PROCESS | 26120 | 08:24:56 INFO - PROCESS | 26120 | [#4] prototype.html Cycles:180 Average:5510.73 Median:6280.87 stddev:1718.96 (27.4%) stddev-sans-first:1679.02 08:24:56 INFO - PROCESS | 26120 | Values: 318.4 318.5 321.6 324.4 327.2 6125.8 6247.0 6300.3 6301.8 6313.8 6105.8 6185.7 6188.6 6190.2 6198.5 4538.2 4634.9 4669.8 4722.8 4745.9 4644.4 4667.7 4675.7 4683.6 4732.5 4621.4 4628.2 4650.7 4651.6 4669.5 4655.7 4657.1 4659.7 4676.0 4680.2 4035.7 4045.4 4045.6 4048.4 4052.7 5848.1 5867.3 5892.6 5904.9 5910.3 5161.5 5247.8 5273.5 5333.4 5395.5 6537.9 6555.2 6556.0 6568.3 6584.1 4324.0 4328.2 4339.6 4344.3 4353.6 6780.9 6856.8 6876.0 6884.1 6936.6 4533.6 4546.3 4546.7 4548.2 4557.4 4510.2 4529.1 4594.8 4607.5 4625.8 5368.7 5395.3 5402.3 5408.2 5419.3 6620.1 6643.1 6666.8 6674.8 6680.3 1597.8 1628.4 1632.2 1636.4 1639.0 1016.8 1023.3 1026.9 1058.8 1083.5 6247.5 6270.7 6272.2 6289.5 6320.1 6738.8 6810.8 6815.0 6815.0 6817.8 6204.1 6291.6 6292.9 6376.7 6398.3 3706.6 3717.9 3730.6 3734.5 3747.8 7245.1 7251.7 7254.6 7260.1 7270.7 7066.9 7067.2 7072.8 7078.4 7081.3 7159.4 7289.8 7313.9 7343.0 7381.2 6847.5 6856.8 6858.9 6864.2 6889.2 6783.3 6785.1 6787.6 6795.2 6817.3 7276.9 7279.0 7325.7 7341.6 7347.4 4517.0 4575.4 4623.0 4641.7 4642.5 6849.0 6876.7 6877.4 6891.0 6918.8 6585.4 6646.8 6662.9 6686.8 6686.8 6603.6 6638.3 6653.1 6654.9 6661.2 6302.9 6427.3 6441.0 6457.6 6488.8 6657.8 6727.6 6730.6 6734.4 6751.7 6473.3 6524.1 6524.4 6529.2 6534.7 08:24:56 INFO - PROCESS | 26120 | 08:24:56 INFO - PROCESS | 26120 | [#5] yui.html Cycles:180 Average:14278.79 Median:24505.58 stddev:16516.50 (67.4%) stddev-sans-first:16531.54 08:24:56 INFO - PROCESS | 26120 | Values: 741.1 778.7 800.2 836.1 837.1 13352.7 13642.8 13644.9 13663.0 13663.4 13278.3 15058.9 15090.1 15199.8 15221.0 847.3 854.3 856.7 859.6 863.0 695.4 842.4 847.4 853.4 856.4 885.5 887.1 888.6 888.8 892.5 869.5 876.9 881.9 882.3 882.9 653.2 654.5 655.6 655.6 657.2 14705.4 14758.2 14758.8 14788.0 14789.8 12702.4 12762.0 12798.3 12877.5 12929.3 10754.6 10776.8 10853.8 10921.6 10956.2 3543.6 3561.2 3586.6 3615.8 3633.1 53465.9 53652.5 53794.7 53933.5 54247.5 9957.4 10110.2 10112.2 10206.0 10279.3 18130.3 18192.6 18215.5 18222.6 18301.0 7463.3 7570.9 7716.1 7766.5 7799.5 4411.2 4486.5 4488.8 4552.4 4584.3 3133.5 3137.8 3164.5 3164.6 3170.2 549.3 554.2 557.5 560.3 564.9 587.0 649.3 656.4 693.1 708.8 7965.5 8362.2 8432.9 8499.0 8675.6 586.8 660.1 690.6 703.8 716.8 3911.9 3936.4 3972.9 4072.8 4167.1 56439.7 58888.7 58997.0 59020.7 59282.1 52493.0 52685.7 52872.2 54053.7 54625.5 46975.0 47329.3 47591.8 47673.3 51800.5 9033.5 9049.1 9057.9 9158.2 9159.1 35482.6 35577.5 35783.3 35916.3 35958.3 40632.4 41041.0 41836.6 43887.3 44600.0 11036.6 11066.8 11268.0 11361.4 11364.8 11871.2 12147.8 12204.6 12359.5 12750.6 11615.7 12003.5 12063.6 12280.9 12457.9 11641.5 11849.2 11868.8 12009.5 12271.2 11402.5 11822.5 11924.2 12106.6 12273.5 9961.7 10141.7 10217.5 10297.1 10525.7 9246.2 9686.7 10057.0 10428.3 10460.6 08:24:56 INFO - PROCESS | 26120 | -------- Summary: end -------- 08:24:56 INFO - PROCESS | 26120 | 08:24:56 INFO - PROCESS | 26120 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:24:56 INFO - PROCESS | 26120 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:24:56 INFO - PROCESS | 26120 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:24:56 INFO - PROCESS | 26120 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:24:56 INFO - PROCESS | 26120 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:24:56 INFO - PROCESS | 26120 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:24:56 INFO - PROCESS | 26120 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:24:56 INFO - PROCESS | 26120 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:24:57 INFO - TEST-INFO | 26120: exit 0 08:24:57 INFO - TEST-OK | dromaeo_css | took 1111242ms 08:24:57 INFO - TEST-START | kraken 08:24:57 INFO - operating with platform_type : linux_ 08:24:57 INFO - Initialising browser for kraken test... 08:24:57 INFO - TEST-INFO | started process 26359 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgsMg0S/profile http://localhost:55063/getInfo.html) 08:25:00 INFO - PROCESS | 26359 | 08:25:00 INFO - PROCESS | 26359 | (process:26432): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:25:01 INFO - PROCESS | 26359 | __metrics Screen width/height:1600/1200 08:25:01 INFO - PROCESS | 26359 | colorDepth:24 08:25:01 INFO - PROCESS | 26359 | Browser inner width/height: 1024/697 08:25:01 INFO - PROCESS | 26359 | __metrics 08:25:02 ERROR - PROCESS | 26359 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 08:25:02 INFO - PROCESS | 26359 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:25:02 INFO - PROCESS | 26359 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:25:02 INFO - PROCESS | 26359 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:25:02 INFO - PROCESS | 26359 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:25:02 INFO - PROCESS | 26359 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:25:02 INFO - PROCESS | 26359 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:25:02 INFO - PROCESS | 26359 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:25:02 INFO - PROCESS | 26359 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:25:02 INFO - PROCESS | 26359 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:25:03 INFO - TEST-INFO | 26359: exit 0 08:25:03 INFO - Browser initialized. 08:25:03 INFO - Running cycle 1/1 for kraken test... 08:25:03 INFO - TEST-INFO | started process 26483 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgsMg0S/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:25:04 INFO - PROCESS | 26483 | 08:25:04 INFO - PROCESS | 26483 | (process:26542): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:25:15 INFO - PROCESS | 26483 | RSS: Main: 158228480 08:25:15 INFO - PROCESS | 26483 | 08:25:17 INFO - PROCESS | 26483 | Cycle 1(1): loaded http://localhost:55063/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55063/tests/kraken/driver.html?testName=audio-beat-detection) 08:25:18 INFO - PROCESS | 26483 | RSS: Main: 165015552 08:25:18 INFO - PROCESS | 26483 | 08:25:21 INFO - PROCESS | 26483 | Cycle 1(1): loaded http://localhost:55063/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55063/tests/kraken/driver.html?testName=audio-dft) 08:25:21 INFO - PROCESS | 26483 | RSS: Main: 169140224 08:25:21 INFO - PROCESS | 26483 | 08:25:24 INFO - PROCESS | 26483 | Cycle 1(1): loaded http://localhost:55063/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55063/tests/kraken/driver.html?testName=audio-fft) 08:25:25 INFO - PROCESS | 26483 | RSS: Main: 160968704 08:25:25 INFO - PROCESS | 26483 | 08:25:27 INFO - PROCESS | 26483 | Cycle 1(1): loaded http://localhost:55063/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55063/tests/kraken/driver.html?testName=audio-oscillator) 08:25:28 INFO - PROCESS | 26483 | RSS: Main: 160149504 08:25:28 INFO - PROCESS | 26483 | 08:25:30 INFO - PROCESS | 26483 | Cycle 1(1): loaded http://localhost:55063/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55063/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:25:30 INFO - PROCESS | 26483 | RSS: Main: 161673216 08:25:30 INFO - PROCESS | 26483 | 08:25:33 INFO - PROCESS | 26483 | Cycle 1(1): loaded http://localhost:55063/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55063/tests/kraken/driver.html?testName=imaging-darkroom) 08:25:34 INFO - PROCESS | 26483 | RSS: Main: 161013760 08:25:34 INFO - PROCESS | 26483 | 08:25:37 INFO - PROCESS | 26483 | Cycle 1(1): loaded http://localhost:55063/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55063/tests/kraken/driver.html?testName=imaging-desaturate) 08:25:38 INFO - PROCESS | 26483 | RSS: Main: 161480704 08:25:38 INFO - PROCESS | 26483 | 08:25:41 INFO - PROCESS | 26483 | Cycle 1(1): loaded http://localhost:55063/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55063/tests/kraken/driver.html?testName=json-parse-financial) 08:25:41 INFO - PROCESS | 26483 | RSS: Main: 163520512 08:25:41 INFO - PROCESS | 26483 | 08:25:43 INFO - PROCESS | 26483 | Cycle 1(1): loaded http://localhost:55063/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55063/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:25:44 INFO - PROCESS | 26483 | RSS: Main: 163901440 08:25:44 INFO - PROCESS | 26483 | 08:25:45 INFO - PROCESS | 26483 | Cycle 1(1): loaded http://localhost:55063/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55063/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:25:46 INFO - PROCESS | 26483 | RSS: Main: 164720640 08:25:46 INFO - PROCESS | 26483 | 08:25:48 INFO - PROCESS | 26483 | Cycle 1(1): loaded http://localhost:55063/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55063/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:25:49 INFO - PROCESS | 26483 | RSS: Main: 163508224 08:25:49 INFO - PROCESS | 26483 | 08:25:51 INFO - PROCESS | 26483 | Cycle 1(1): loaded http://localhost:55063/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55063/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:25:52 INFO - PROCESS | 26483 | RSS: Main: 164868096 08:25:52 INFO - PROCESS | 26483 | 08:25:54 INFO - PROCESS | 26483 | Cycle 1(1): loaded http://localhost:55063/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55063/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:25:55 INFO - PROCESS | 26483 | RSS: Main: 164257792 08:25:55 INFO - PROCESS | 26483 | 08:25:57 INFO - PROCESS | 26483 | Cycle 1(1): loaded http://localhost:55063/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55063/tests/kraken/driver.html?testName=ai-astar) 08:25:57 INFO - PROCESS | 26483 | RSS: Main: 166293504 08:25:57 INFO - PROCESS | 26483 | 08:25:57 INFO - PROCESS | 26483 | __start_tp_report 08:25:57 INFO - PROCESS | 26483 | _x_x_mozilla_page_load 08:25:57 INFO - PROCESS | 26483 | _x_x_mozilla_page_load_details 08:25:57 INFO - PROCESS | 26483 | |i|pagename|runs| 08:25:57 INFO - PROCESS | 26483 | |0;ai-astar;113;107;113;111;112;123;111;111;112;112 08:25:57 INFO - PROCESS | 26483 | |1;audio-beat-detection;150;128;153;173;131;152;151;129;165;127 08:25:57 INFO - PROCESS | 26483 | |2;audio-dft;162;162;164;162;161;161;161;166;169;164 08:25:57 INFO - PROCESS | 26483 | |3;audio-fft;74;73;74;73;73;74;75;145;75;74 08:25:57 INFO - PROCESS | 26483 | |4;audio-oscillator;97;97;152;97;97;97;145;95;96;140 08:25:57 INFO - PROCESS | 26483 | |5;imaging-gaussian-blur;119;118;118;118;115;116;116;116;115;117 08:25:57 INFO - PROCESS | 26483 | |6;imaging-darkroom;147;147;147;148;148;146;148;154;147;147 08:25:57 INFO - PROCESS | 26483 | |7;imaging-desaturate;97;98;97;98;96;96;97;96;101;97 08:25:57 INFO - PROCESS | 26483 | |8;json-parse-financial;57;57;58;58;58;59;57;57;57;55 08:25:57 INFO - PROCESS | 26483 | |9;json-stringify-tinderbox;70;69;67;68;71;69;68;67;68;69 08:25:57 INFO - PROCESS | 26483 | |10;stanford-crypto-aes;83;85;83;84;85;84;83;90;85;83 08:25:57 INFO - PROCESS | 26483 | |11;stanford-crypto-ccm;119;116;130;118;121;121;122;132;120;121 08:25:57 INFO - PROCESS | 26483 | |12;stanford-crypto-pbkdf2;142;153;151;153;159;151;161;150;154;152 08:25:57 INFO - PROCESS | 26483 | |13;stanford-crypto-sha256-iterative;70;69;73;71;72;68;69;70;70;68 08:25:57 INFO - PROCESS | 26483 | __end_tp_report 08:25:57 INFO - PROCESS | 26483 | __start_cc_report 08:25:57 INFO - PROCESS | 26483 | _x_x_mozilla_cycle_collect,773 08:25:57 INFO - PROCESS | 26483 | __end_cc_report 08:25:57 INFO - PROCESS | 26483 | __startTimestamp1456590357443__endTimestamp 08:25:57 INFO - PROCESS | 26483 | 08:25:57 INFO - PROCESS | 26483 | ------- Summary: start ------- 08:25:57 INFO - PROCESS | 26483 | Number of tests: 14 08:25:57 INFO - PROCESS | 26483 | 08:25:57 INFO - PROCESS | 26483 | [#0] ai-astar Cycles:10 Average:112.50 Median:112.00 stddev:4.06 (3.6%) stddev-sans-first:4.30 08:25:57 INFO - PROCESS | 26483 | Values: 113.0 107.0 113.0 111.0 112.0 123.0 111.0 111.0 112.0 112.0 08:25:57 INFO - PROCESS | 26483 | 08:25:57 INFO - PROCESS | 26483 | [#1] audio-beat-detection Cycles:10 Average:145.90 Median:151.50 stddev:16.38 (10.8%) stddev-sans-first:17.31 08:25:57 INFO - PROCESS | 26483 | Values: 150.0 128.0 153.0 173.0 131.0 152.0 151.0 129.0 165.0 127.0 08:25:57 INFO - PROCESS | 26483 | 08:25:57 INFO - PROCESS | 26483 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:2.62 (1.6%) stddev-sans-first:2.74 08:25:57 INFO - PROCESS | 26483 | Values: 162.0 162.0 164.0 162.0 161.0 161.0 161.0 166.0 169.0 164.0 08:25:57 INFO - PROCESS | 26483 | 08:25:57 INFO - PROCESS | 26483 | [#3] audio-fft Cycles:10 Average:81.00 Median:74.00 stddev:22.50 (30.4%) stddev-sans-first:23.72 08:25:57 INFO - PROCESS | 26483 | Values: 74.0 73.0 74.0 73.0 73.0 74.0 75.0 145.0 75.0 74.0 08:25:57 INFO - PROCESS | 26483 | 08:25:57 INFO - PROCESS | 26483 | [#4] audio-oscillator Cycles:10 Average:111.30 Median:97.00 stddev:23.89 (24.6%) stddev-sans-first:24.78 08:25:57 INFO - PROCESS | 26483 | Values: 97.0 97.0 152.0 97.0 97.0 97.0 145.0 95.0 96.0 140.0 08:25:57 INFO - PROCESS | 26483 | 08:25:57 INFO - PROCESS | 26483 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.50 stddev:1.40 (1.2%) stddev-sans-first:1.24 08:25:57 INFO - PROCESS | 26483 | Values: 119.0 118.0 118.0 118.0 115.0 116.0 116.0 116.0 115.0 117.0 08:25:57 INFO - PROCESS | 26483 | 08:25:57 INFO - PROCESS | 26483 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:147.50 stddev:2.23 (1.5%) stddev-sans-first:2.35 08:25:57 INFO - PROCESS | 26483 | Values: 147.0 147.0 147.0 148.0 148.0 146.0 148.0 154.0 147.0 147.0 08:25:57 INFO - PROCESS | 26483 | 08:25:57 INFO - PROCESS | 26483 | [#7] imaging-desaturate Cycles:10 Average:97.30 Median:97.00 stddev:1.49 (1.5%) stddev-sans-first:1.58 08:25:57 INFO - PROCESS | 26483 | Values: 97.0 98.0 97.0 98.0 96.0 96.0 97.0 96.0 101.0 97.0 08:25:57 INFO - PROCESS | 26483 | 08:25:57 INFO - PROCESS | 26483 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.50 stddev:1.06 (1.8%) stddev-sans-first:1.12 08:25:57 INFO - PROCESS | 26483 | Values: 57.0 57.0 58.0 58.0 58.0 59.0 57.0 57.0 57.0 55.0 08:25:57 INFO - PROCESS | 26483 | 08:25:57 INFO - PROCESS | 26483 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:1.26 (1.8%) stddev-sans-first:1.24 08:25:57 INFO - PROCESS | 26483 | Values: 70.0 69.0 67.0 68.0 71.0 69.0 68.0 67.0 68.0 69.0 08:25:57 INFO - PROCESS | 26483 | 08:25:57 INFO - PROCESS | 26483 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.50 stddev:2.12 (2.5%) stddev-sans-first:2.18 08:25:57 INFO - PROCESS | 26483 | Values: 83.0 85.0 83.0 84.0 85.0 84.0 83.0 90.0 85.0 83.0 08:25:57 INFO - PROCESS | 26483 | 08:25:57 INFO - PROCESS | 26483 | [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:121.00 stddev:5.08 (4.2%) stddev-sans-first:5.27 08:25:57 INFO - PROCESS | 26483 | Values: 119.0 116.0 130.0 118.0 121.0 121.0 122.0 132.0 120.0 121.0 08:25:57 INFO - PROCESS | 26483 | 08:25:57 INFO - PROCESS | 26483 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.60 Median:153.00 stddev:5.15 (3.4%) stddev-sans-first:3.77 08:25:57 INFO - PROCESS | 26483 | Values: 142.0 153.0 151.0 153.0 159.0 151.0 161.0 150.0 154.0 152.0 08:25:57 INFO - PROCESS | 26483 | 08:25:57 INFO - PROCESS | 26483 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:1.63 (2.3%) stddev-sans-first:1.73 08:25:57 INFO - PROCESS | 26483 | Values: 70.0 69.0 73.0 71.0 72.0 68.0 69.0 70.0 70.0 68.0 08:25:57 INFO - PROCESS | 26483 | -------- Summary: end -------- 08:25:57 INFO - PROCESS | 26483 | 08:25:57 INFO - PROCESS | 26483 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:25:57 INFO - PROCESS | 26483 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:25:57 INFO - PROCESS | 26483 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:25:57 INFO - PROCESS | 26483 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:25:57 INFO - PROCESS | 26483 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:25:57 INFO - PROCESS | 26483 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:25:57 INFO - PROCESS | 26483 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:25:58 INFO - TEST-INFO | 26483: exit 0 08:25:58 INFO - TEST-OK | kraken | took 61306ms 08:25:58 INFO - SUITE-END | took 1172s 08:25:58 INFO - Completed test suite (00:19:32) 08:25:58 INFO - Working with test: dromaeo_css 08:25:58 INFO - Generating results file: dromaeo_css 08:25:58 INFO - Working with test: kraken 08:25:58 INFO - Generating results file: kraken 08:25:58 INFO - javascript benchmark 08:25:58 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:25:58 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 08:25:58 INFO - process_Request line: dromaeo_css 6931.44 graph.html#tests=[[72,64,43]] 08:25:58 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:25:58 INFO - process_Request line: kraken 1530.90 graph.html#tests=[[232,64,43]] 08:25:58 INFO - RETURN: dromaeo_css: 6931.44 08:25:58 INFO - RETURN: kraken: 1530.90 08:25:58 INFO - javascript benchmark 08:25:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3186.5379519969606, 3208.0536241808663, 3248.0742988248326, 3253.2192273854275, 3259.5925509311337, 5225.163973764198, 5234.424213336535, 5235.947640523594, 5256.474352564742, 5275.49882761138, 5245.396779370373, 5294.047071527133, 5297.947020529803, 5300.708461034651, 5307.73461326934, 4774.262053498332, 4775.426948766144, 4787.281907713836, 4944.1594928862, 4960.751962401883, 4778.665493415462, 4804.951950480503, 4835.516448355154, 4861.0, 4889.3888263967, 4790.281457781326, 4799.9760001199775, 4801.831935882262, 4813.542713442217, 4851.151048566487, 4781.139394908915, 4784.856454306341, 4811.78346974387, 4814.518548145193, 4852.296417019513, 4771.427428708543, 4830.227163653799, 4841.419029716457, 4860.659753817235, 4864.0, 5104.770285337168, 5136.691798492103, 5149.768260428253, 5149.819756308549, 5177.249298851683, 5585.692786896719, 5641.971790141064, 5643.351014633328, 5660.971695141539, 5700.686462244575, 5639.520640745542, 5692.943070569324, 5768.0, 5778.104393818965, 5867.559933004999, 5401.162819762943, 5407.783688652488, 5416.133418652997, 5420.783168673248, 5422.240886275925, 5836.766529338864, 5838.883222335529, 5839.766409343579, 5848.181254624356, 5854.590178687451, 5420.620556561003, 5600.803971860965, 5601.383847776741, 5612.803551875665, 5654.971725141348, 5564.248826408383, 5638.323401191801, 5650.237217975603, 5657.57568182388, 5662.094064949588, 5634.746436410372, 5640.802571909963, 5651.858703532363, 5666.829995100071, 5686.118651609007, 5538.0, 5627.099664053813, 5642.181883626851, 5706.9429305707245, 5731.570132240098, 4314.395984562164, 4320.308750599889, 4325.740455572675, 4328.372386004012, 4358.694891357638, 3871.2257548490416, 3885.7862817545306, 3911.6675082618294, 3945.191235796655, 3965.266425711253, 5365.731713414314, 5382.542483888913, 5385.649932754437, 5408.783648654088, 5448.210009548593, 5650.915236271459, 5656.5757568181725, 5665.886682266331, 5679.772809087673, 5700.458456446631, 5341.4925582069645, 5350.571954243729, 5370.489803468664, 5370.597205209625, 5408.567314614821, 4767.308740232646, 4792.592629626451, 4795.400574928134, 4804.759762011886, 4838.661293709477, 5820.82537523875, 5861.20873682056, 5864.67744274069, 5892.787049780622, 5944.910826337608, 5571.303587051619, 5586.720663966867, 5621.634593751393, 5642.548596112383, 5667.064934285797, 5934.643921364732, 5941.9405805943115, 5960.314563825215, 5979.162917191509, 5989.7304621293015, 5596.440355964371, 5619.859503512282, 5630.915536266877, 5631.774729010794, 5652.5477961762135, 5575.080111781511, 5636.520895723909, 5699.8860022800145, 5700.800471983461, 5751.482366587027, 5410.458954104715, 5497.780088796563, 5533.0, 5545.279113715191, 5573.693446860461, 5481.890362192654, 5520.171974203741, 5536.7785288588, 5539.446055394589, 5550.0, 5321.574274057989, 5356.116240820221, 5367.731613419235, 5386.757595908115, 5411.918821217763, 5465.590080744039, 5532.778688852401, 5626.634268772516, 5631.605787594829, 5683.9715801420725, 5448.673079615236, 5457.508824205841, 5465.234867118686, 5471.124620060771, 5489.917651235314], "unit": "score", "name": "dojo.html", "value": 5232.907052787635}, {"lowerIsBetter": false, "replicates": [521.5879455230371, 544.0805039483275, 547.2693953571982, 554.0857584984777, 572.768028948276, 35505.64494355056, 36135.0, 36361.09097272566, 36466.63533364666, 36492.81753591232, 40099.59900400995, 41075.79462102693, 41114.38328425076, 41205.58794412055, 41355.37966930499, 8534.87197692035, 8588.828223435528, 8673.479591224515, 8740.125987401241, 8751.73099900514, 8488.53313067781, 8581.52801595912, 8586.742397728047, 8629.266512346427, 8641.13588641134, 8610.913890861073, 8619.784505387384, 8650.43772154811, 8728.912710872904, 8730.214280714734, 8550.2732267757, 8591.05498395176, 8661.437006594582, 8678.566071696421, 8692.174243446863, 8545.57272136397, 8676.175763302475, 8712.21590056898, 8734.606942687531, 8749.47503149813, 37404.43893341602, 37804.0, 37822.81088594539, 37861.43207851885, 37880.242395151945, 3460.532828068204, 3536.717062634983, 3558.3594952908466, 3633.400488919325, 4045.7370270932297, 29342.853285733647, 29518.70481295181, 29972.03766192979, 30249.395012099856, 31091.844540777376, 3692.390755525362, 3753.0, 3760.2479504099288, 3841.1741475582603, 3844.1735026969054, 281232.75068997423, 282421.0, 283117.0, 283200.0, 283897.0, 45659.771701141945, 59027.81944361175, 59753.701231493564, 59939.40060599338, 60071.39928600746, 43868.56131438709, 44156.3376549352, 44247.77876110599, 44345.55654443479, 44367.55632443699, 15035.473758418402, 15061.0, 15084.396624135132, 15107.39570417193, 15232.3907043717, 12156.331401772988, 12163.209391389531, 12202.511899523919, 12216.083793715507, 12247.203931744409, 14379.496717615042, 14386.568402947929, 14536.636584085483, 14539.636509087146, 14646.780298295535, 5846.386129456431, 5893.793717219963, 5907.172995780594, 5919.467247947619, 5976.312724036705, 1007.5768177365524, 1056.5034433816095, 1064.0264158295074, 1065.6183430033868, 1088.455772113943, 28911.855440722662, 29042.27394315159, 29272.0, 29552.0, 29592.852035739685, 1088.3034857691084, 1089.1559041742555, 1103.5585765693786, 1105.3533682795655, 1176.6293617510457, 14711.779323310158, 15300.846991530165, 15302.617434564225, 15313.540593782205, 15323.693526129638, 316294.0, 317218.0, 320355.0, 321596.0, 322083.0, 52210.21684674733, 53650.73174634102, 53842.73078634582, 53928.730356347965, 53936.46063539393, 1306.2162702378687, 1325.1982550556968, 1332.9600111996656, 1339.9531016414574, 1344.717609302038, 27887.0, 28173.57739633866, 28651.5702264462, 29334.26664333409, 29376.0, 47251.0, 47469.52530474651, 47791.283130752374, 47862.0, 47919.0, 297591.0, 298787.0, 299209.0, 299427.0, 299456.0, 32347.676523234466, 32450.513242301855, 32709.509357359184, 32906.17734556655, 32986.34027319488, 44827.327590086825, 45115.54884451245, 45243.09513809771, 45523.77238113788, 45786.54213457956, 36894.44658330181, 37436.0, 37450.0, 37956.62043379531, 38110.23779524338, 37224.81387593045, 37706.8114659425, 37743.0, 38412.23175536418, 38412.42381364226, 36675.633243667224, 37201.0, 37255.441168381956, 37737.62262377341, 38280.42579361256, 32531.349373011933, 33751.19865750375, 34211.4868276981, 34701.652983469845, 34783.652163478044, 25333.61999569971, 25469.3632659185, 25861.741382585933, 26000.8699956499, 26168.8691556541], "unit": "score", "name": "ext.html", "value": 18203.385703823893}, {"lowerIsBetter": false, "replicates": [353.4256832646948, 353.60219752778124, 355.9430491121421, 357.3817296077787, 363.07959323115904, 16835.494935151935, 16918.49244522663, 17350.82649173508, 17396.826031739678, 17424.651506969854, 16035.518934431957, 16185.19074046299, 16953.152342382895, 16968.915155424238, 16995.790547228873, 5103.770330335125, 5337.733113344337, 5479.424660410659, 5491.0, 5513.669179849222, 5422.15956526739, 5457.727113644321, 5478.178273259023, 5491.0, 5497.615166938296, 4842.055799119174, 5006.599472042228, 5048.242763585473, 5442.183672449125, 5447.863803404907, 4935.432425271104, 4980.576650984689, 4981.178105612569, 4983.551480366767, 5041.218611115265, 4816.85549433514, 4835.516448355136, 4847.418309802846, 4848.903021939576, 4932.704037757746, 12213.328266945315, 12469.501219951191, 13201.669958251025, 20135.597288054156, 20211.595768084702, 2091.1217288738767, 2121.7984291492285, 2271.693321401606, 2554.846709197454, 2737.0283549340097, 9247.768805779842, 9307.488088155149, 9631.518424078839, 10980.0, 12803.231806091571, 1748.9912550437293, 1818.299954517507, 1821.772278465192, 1846.1230915315252, 1891.2435025989578, 61601.513868831054, 64263.0, 64844.351556484304, 65722.67138664276, 66930.99603506, 9367.672131475365, 9477.24182065447, 9548.952255238679, 9691.612335506501, 9715.902840971641, 12317.0, 12461.1900226485, 12469.0, 12486.75026499465, 12498.687532811753, 7126.928730712731, 7217.06178196831, 7272.8181795454475, 7336.816579585553, 7368.336849683555, 7129.714811407589, 7217.92782072183, 7221.53060051095, 7229.49393542447, 7305.196428392873, 4148.668106551469, 4155.854545090907, 4161.583841615814, 4176.206520761046, 4177.749335039907, 1745.9650806984043, 1777.4845294864604, 1789.2753434858903, 1796.2725096336005, 1846.6306738652324, 886.8935727712716, 914.29599208609, 929.8047410043831, 997.670768646345, 1024.9231307651955, 15736.449224277096, 16086.276117574736, 16243.02541847493, 16575.336986520404, 16728.079955602316, 929.2426672262085, 946.5172761891484, 958.0993865766158, 960.2078285414561, 976.5215044628081, 9132.132447417485, 9444.433333999981, 9453.385529940531, 9498.430094194371, 9591.0, 446367.0, 462044.0, 466741.0, 468099.0, 469063.0, 71076.0, 72054.63972680103, 74246.62876685582, 74325.0, 74676.0, 996.6661168508631, 997.2520609542843, 1000.7097941596855, 1002.8245057114975, 1013.8175128476797, 14373.0, 14542.200178990257, 14608.0, 14742.2628868554, 14935.775963360342, 24135.879320603286, 28098.71901280961, 31315.217119572193, 33105.83447082749, 34984.47523287102, 43090.353644694726, 43594.56405436032, 44219.55780442154, 44445.33332000087, 44761.32858007067, 7633.923660763543, 7730.7680769577, 7792.7142021565805, 7913.406494512819, 7984.6806127754235, 11724.58963936258, 12121.939390302992, 12409.255444673348, 12699.111062225926, 12857.100003000074, 10909.0, 10941.507632156732, 11053.502592383202, 11095.16786241019, 11212.0, 10771.730706732395, 10942.781144377228, 11251.7749645005, 11274.154438416988, 11274.549018039186, 10620.150387969099, 11112.722181945515, 11145.609903653332, 11231.831522527005, 11362.829557556477, 7781.844363112593, 7783.377329813715, 7898.802529936797, 7918.643661035152, 7976.481528700616, 10171.084602385821, 10276.743081422725, 10314.381137131797, 10399.688009359428, 10571.62999295021], "unit": "score", "name": "jquery.html", "value": 8198.452074171018}, {"lowerIsBetter": false, "replicates": [1462.678210793625, 1484.027961685096, 1674.7320428731405, 1792.9282828686853, 1844.8247416495437, 7548.169701332849, 7567.508111972725, 7708.961455192723, 7741.458097933147, 7742.8451430971345, 7678.731244406447, 7716.189800070996, 7752.844943101135, 7758.379329653629, 7809.258120478559, 2251.5046689728274, 2277.829162812787, 2284.680144779732, 2286.862788232703, 2289.107248173214, 2250.122452243618, 2288.473651060249, 2289.7366802817637, 2290.3129061281634, 2292.495650956787, 2260.8982595783227, 2261.7398999115067, 2262.332611879491, 2281.0, 2283.771622837711, 2274.8748818814956, 2285.0517035430275, 2290.083966413448, 2294.8623082615013, 2300.1374484568205, 2208.149862303009, 2215.878126703031, 2221.0893533651288, 2223.7665045170347, 2228.398332450229, 7689.961550192269, 7732.613369331567, 7735.226477352276, 7766.57283849388, 7779.33875620573, 4483.596476317114, 4605.009922866566, 4636.0, 4639.512851150648, 4639.837605683819, 2987.14866263114, 3018.8490575471137, 3124.297033167542, 3130.624325080982, 3175.1903264667594, 1038.6520515627274, 1043.519980808829, 1790.8477779388768, 1864.44998725375, 1900.7719073711105, 10207.591696332138, 10243.487825608765, 10307.690769276935, 10336.379817210916, 10348.120409765179, 3829.0810205550465, 3909.0, 3956.643902048829, 3987.182627561343, 4001.8799436016966, 8185.386096042821, 8229.95885020583, 8231.42380033392, 8236.958815206006, 8270.958645206736, 4625.1443482955765, 4639.768011599406, 4639.884002899887, 4643.605293550086, 4659.068186362673, 4162.875113746592, 4243.5119961204855, 4256.106217694257, 4264.168487144977, 4287.506936702257, 3230.7415406767873, 3325.251818340854, 3334.333133373335, 3341.3818443588016, 3343.8160901150673, 991.2367477042781, 993.1657407777501, 1000.9249306302056, 1001.4892404873567, 1002.3284399452384, 1322.3190057120592, 1328.2561765411401, 1336.7059246965653, 1352.8376594808685, 1363.236587510997, 7302.087239095114, 7317.817054573678, 7318.194998550155, 7365.594892280868, 7376.594287314249, 436.79907242668094, 443.94895582409475, 446.65607482238494, 1216.5133946421502, 1241.782688029591, 5720.913026524947, 5785.508231800344, 5806.883862322815, 5868.794592189253, 5898.0, 9205.079492050741, 9469.053094690476, 9507.0, 9522.143007129253, 9525.809483810284, 8610.612522436506, 8757.60590773404, 9237.399569027992, 9338.393004454825, 9370.953145234367, 6939.271376505495, 7020.508564400443, 7031.824204394931, 7046.084009078787, 7148.0, 7104.680289386886, 7229.819254518679, 7281.089863767029, 7291.963540182265, 7343.926560734324, 8115.350771938349, 8214.753557393287, 8244.051934027424, 8303.709370172015, 8448.324134069382, 8287.0, 8402.41183117176, 8546.700865469678, 8637.438566493158, 8651.394402391772, 6590.110335104891, 6885.070515480346, 7525.0, 7544.170141284345, 7587.772366829004, 7103.360697537247, 7117.501774875709, 7155.463340249398, 7172.318629730167, 7180.030695855992, 6447.806565803034, 6515.837104072247, 6570.080188773671, 6691.732330706717, 6701.128853249046, 6477.708503117466, 6486.805395838132, 6520.510961677988, 6601.273859875506, 6606.10817539626, 6389.2971773105855, 6472.288048314587, 6491.123698300669, 6587.110740050223, 6611.537192396486, 6216.658083805253, 6360.332165122781, 6399.520035997412, 6400.647964362005, 6424.4860411166055, 6387.968060159856, 6456.2575303838785, 6471.838204044937, 6516.218053833571, 6521.315261897433], "unit": "score", "name": "mootools.html", "value": 4418.820806026244}, {"lowerIsBetter": false, "replicates": [318.4061724883094, 318.5333486442361, 321.5915786950574, 324.38205219057676, 327.1624640919246, 6125.754969801208, 6247.0, 6300.275468321144, 6301.842453938654, 6313.810585682425, 6105.847353816157, 6185.6597887116195, 6188.566800323979, 6190.226221722285, 6198.504119670427, 4538.183127037132, 4634.86095417138, 4669.836555720551, 4722.763861806896, 4745.928811067828, 4644.396228490292, 4667.6965997210245, 4675.696079754805, 4683.578477936985, 4732.526747325274, 4621.399218101642, 4628.1669299526075, 4650.7442090685, 4651.581357677808, 4669.463011753641, 4655.650826188033, 4657.138429390574, 4659.650526210531, 4675.976620116878, 4680.227762419197, 4035.717499775017, 4045.393191021341, 4045.554988951213, 4048.3522636378334, 4052.716309858311, 5848.093545500455, 5867.325257595346, 5892.558058145613, 5904.881902361972, 5910.320313163998, 5161.458046905059, 5247.816326428557, 5273.525382715574, 5333.4399888011585, 5395.541378982752, 6537.934620653828, 6555.246146693144, 6555.967220163869, 6568.343165683441, 6584.111144995412, 4324.0, 4328.177646247234, 4339.566043395666, 4344.261475549164, 4353.6299414549485, 6780.864382712318, 6856.760013399507, 6876.0, 6884.139482564679, 6936.583804971718, 4533.591976722111, 4546.29532422475, 4546.704464209815, 4548.204064288736, 4557.430321209848, 4510.233260345749, 4529.139463501924, 4594.770261486912, 4607.470140933836, 4625.768711564476, 5368.651037682538, 5395.325584301962, 5402.297701298885, 5408.161734931092, 5419.3225846769155, 6620.106285651472, 6643.1031810704935, 6666.766663166766, 6674.833129171712, 6680.265170831205, 1597.7603359496168, 1628.3893539922528, 1632.208378936215, 1636.4354297767488, 1638.9672206555801, 1016.8118898003893, 1023.3194925374692, 1026.8870424253325, 1058.8305871060593, 1083.5178345636116, 6247.531435142382, 6270.714503526766, 6272.247330320391, 6289.496840252768, 6320.083587879732, 6738.764143254963, 6810.795676129724, 6815.0, 6815.045893574904, 6817.829554261084, 6204.100405441186, 6291.552942823177, 6292.905606415908, 6376.681165941777, 6398.328175541595, 3706.5737440194184, 3717.925641487155, 3730.5709843367817, 3734.514513113278, 3747.8126093695205, 7245.130584329809, 7251.74618888347, 7254.600996945219, 7260.092488438945, 7270.745523906638, 7066.858662826715, 7067.151941766918, 7072.787816365517, 7078.433725301964, 7081.291870812981, 7159.427245820426, 7289.817754556178, 7313.853722925512, 7343.0, 7381.224971378036, 6847.48643851723, 6856.794296171123, 6858.862822743617, 6864.176298844171, 6889.173299204128, 6783.287754785676, 6785.117934668461, 6787.592744435349, 6795.150606174228, 6817.318268173143, 7276.927230727625, 7279.017332660023, 7325.743598974011, 7341.632918353954, 7347.448941329529, 4516.954830451785, 4575.359449676981, 4623.0, 4641.675082744176, 4642.53574642533, 6849.0, 6876.724931002704, 6877.415419689382, 6890.965545172242, 6918.792436226921, 6585.374389432996, 6646.833829154117, 6662.900056499059, 6686.765963191265, 6686.765963191265, 6603.636799976048, 6638.302978187414, 6653.068570400051, 6654.866902661823, 6661.16735408074, 6302.873942521215, 6427.260865000585, 6440.967795160994, 6457.644829534421, 6488.837779055561, 6657.800265992028, 6727.596344219362, 6730.629815360202, 6734.3602357775935, 6751.729930802713, 6473.320301368289, 6524.086627872007, 6524.412802847766, 6529.216494020558, 6534.705938232696], "unit": "score", "name": "prototype.html", "value": 4937.921852166432}, {"lowerIsBetter": false, "replicates": [741.1328745367919, 778.7430148051144, 800.2157885272433, 836.1429534726905, 837.0917554453417, 13352.732945341088, 13642.795358069638, 13644.931775341109, 13663.0, 13663.385147668354, 13278.33608319585, 15058.924705376485, 15090.09459432432, 15199.772003419957, 15221.0, 847.2798121596655, 854.3122786157141, 856.6830272799042, 859.6303589456531, 862.9611667474978, 695.4123765418238, 842.3808500751942, 847.3560094328324, 853.3727710133047, 856.4347530629785, 885.5483703311294, 887.0685779931079, 888.6090120347059, 888.844452220862, 892.4957399069538, 869.5174178331024, 876.9386142969995, 881.9029906710257, 882.298572634757, 882.8543290357115, 653.1574269192736, 654.5058480846977, 655.577152736487, 655.6295692933477, 657.2211928864311, 14705.411783528752, 14758.188299643516, 14758.778618320734, 14788.0, 14789.778153327708, 12702.364881755875, 12762.0, 12798.296093714842, 12877.484900604059, 12929.288889111094, 10754.623588174454, 10776.78446431075, 10853.837192442119, 10921.617743378943, 10956.233063685546, 3543.6456354364614, 3561.1809283864595, 3586.605473397924, 3615.8011309377976, 3633.1098880774116, 53465.93068138654, 53652.46347536513, 53794.73102634462, 53933.460665393235, 54247.45752542464, 9957.352772069793, 10110.191184705352, 10112.191024718006, 10206.0, 10279.331843430153, 18130.274789008556, 18192.636147277244, 18215.544611384557, 18222.63554728898, 18301.0, 7463.290987356192, 7570.886436703454, 7716.112647045549, 7766.456348055582, 7799.454038217384, 4411.1618792429335, 4486.528914463999, 4488.820447182142, 4552.362669226311, 4584.3352713856975, 3133.451645961993, 3137.7803553751473, 3164.47786115293, 3164.604424446944, 3170.1916011416943, 549.3353042818235, 554.1715135871897, 557.5010365722655, 560.3332034878482, 564.8870225954826, 586.9765209391577, 649.302000349626, 656.3993945539873, 693.1093544794915, 708.7731925783803, 7965.4822436541435, 8362.247397734232, 8432.915670843337, 8499.0, 8675.609597568124, 586.7770247306082, 660.072597999811, 690.5718454558106, 703.802935178151, 716.781381678593, 3911.882643520699, 3936.3701807710627, 3972.9205415892097, 4072.775997320176, 4167.1457351243525, 56439.71780141073, 58888.70555647194, 58997.0, 59020.704896476105, 59282.11076833851, 52493.0, 52685.73657131766, 52872.20691689628, 54053.72973135109, 54625.45374546283, 46975.0, 47329.29006064912, 47591.76204119027, 47673.28490072652, 51800.48199518032, 9033.457992520469, 9049.140331668481, 9057.864132037894, 9158.221551168226, 9159.129882661136, 35482.645173547935, 35577.46633800443, 35783.28433431369, 35916.28167436584, 35958.28083438264, 40632.390514142906, 41041.0, 41836.58163418327, 43887.34168987404, 44600.0, 11036.613718519813, 11066.833997489883, 11268.0, 11361.43192840338, 11364.772704545698, 11871.244421173154, 12147.75704485923, 12204.572839950559, 12359.505619775467, 12750.553730619384, 11615.709607259887, 12003.459844306852, 12063.638090857288, 12280.877191227974, 12457.875421245672, 11641.53433862636, 11849.170558060852, 11868.76262474763, 12009.519619215134, 12271.202371845802, 11402.543898243977, 11822.527098915947, 11924.165308428326, 12106.576269830513, 12273.509059637514, 9961.701148965543, 10141.746456338651, 10217.489125543842, 10297.12474439681, 10525.684229473129, 9246.167844893991, 9686.70939871805, 10056.98330107078, 10428.322159059637, 10460.581576736846], "unit": "score", "name": "yui.html", "value": 6507.699066504812}], "name": "dromaeo_css", "value": 6931.443080606554}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 107.0, 113.0, 111.0, 112.0, 123.0, 111.0, 111.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.5}, {"lowerIsBetter": true, "replicates": [150.0, 128.0, 153.0, 173.0, 131.0, 152.0, 151.0, 129.0, 165.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.9}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 164.0, 162.0, 161.0, 161.0, 161.0, 166.0, 169.0, 164.0], "unit": "score", "name": "audio-dft", "value": 163.2}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 74.0, 73.0, 73.0, 74.0, 75.0, 145.0, 75.0, 74.0], "unit": "score", "name": "audio-fft", "value": 81.0}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 152.0, 97.0, 97.0, 97.0, 145.0, 95.0, 96.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 111.3}, {"lowerIsBetter": true, "replicates": [119.0, 118.0, 118.0, 118.0, 115.0, 116.0, 116.0, 116.0, 115.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 148.0, 148.0, 146.0, 148.0, 154.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.9}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 97.0, 98.0, 96.0, 96.0, 97.0, 96.0, 101.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 97.3}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 58.0, 58.0, 58.0, 59.0, 57.0, 57.0, 57.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.3}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 67.0, 68.0, 71.0, 69.0, 68.0, 67.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 83.0, 84.0, 85.0, 84.0, 83.0, 90.0, 85.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.5}, {"lowerIsBetter": true, "replicates": [119.0, 116.0, 130.0, 118.0, 121.0, 121.0, 122.0, 132.0, 120.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.0}, {"lowerIsBetter": true, "replicates": [142.0, 153.0, 151.0, 153.0, 159.0, 151.0, 161.0, 150.0, 154.0, 152.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.6}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 73.0, 71.0, 72.0, 68.0, 69.0, 70.0, 70.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.0}], "name": "kraken", "value": 1530.8999999999996}]} 08:25:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1530.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6931.44"}}} 08:25:58 INFO - Return code: 0 08:25:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:25:58 ERROR - # TBPL SUCCESS # 08:25:58 INFO - Running post-action listener: _resource_record_post_action 08:25:58 INFO - Running post-run listener: _resource_record_post_run 08:25:59 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535998464; Read time: 8; Write time: 478464 08:25:59 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 240205824; Read time: 0; Write time: 280748 08:25:59 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295063552; Read time: 8; Write time: 197708 08:25:59 INFO - Running post-run listener: _upload_blobber_files 08:25:59 INFO - Blob upload gear active. 08:25:59 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:25:59 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 08:25:59 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'] 08:25:59 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 08:26:00 INFO - (blobuploader) - INFO - Open directory for files ... 08:26:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:26:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:26:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:26:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:01 INFO - (blobuploader) - INFO - Done attempting. 08:26:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:26:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:26:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:26:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:01 INFO - (blobuploader) - INFO - Done attempting. 08:26:01 INFO - (blobuploader) - INFO - Iteration through files over. 08:26:01 INFO - Return code: 0 08:26:01 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:26:01 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:26:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ed30cd78a6980c4eb78dd6522b0b56c15da65c0ba06fda3ca9f8a7d5fb49276362a97fdcfcfb1c3c37e3f01ba25be30a6d517b4e0731b7648f0d9e8f12a1a6ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2cbe05d2682c0d6f9d53190e922e86c80af6be3bdc922dbdcc030113d50e9b06d53b1767eed8a8ad3c87dfbb051fa8b4d74a7352e9abddc050f90c471b6459e4"} 08:26:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:26:01 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:26:01 INFO - Contents: 08:26:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ed30cd78a6980c4eb78dd6522b0b56c15da65c0ba06fda3ca9f8a7d5fb49276362a97fdcfcfb1c3c37e3f01ba25be30a6d517b4e0731b7648f0d9e8f12a1a6ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2cbe05d2682c0d6f9d53190e922e86c80af6be3bdc922dbdcc030113d50e9b06d53b1767eed8a8ad3c87dfbb051fa8b4d74a7352e9abddc050f90c471b6459e4"} 08:26:01 INFO - Running post-run listener: copy_logs_to_upload_dir 08:26:01 INFO - Copying logs to upload dir... 08:26:01 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 08:26:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.215025 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-02-27 08:26:01.183617) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-27 08:26:01.191602) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1456587746.448507-749278510 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/ed30cd78a6980c4eb78dd6522b0b56c15da65c0ba06fda3ca9f8a7d5fb49276362a97fdcfcfb1c3c37e3f01ba25be30a6d517b4e0731b7648f0d9e8f12a1a6ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2cbe05d2682c0d6f9d53190e922e86c80af6be3bdc922dbdcc030113d50e9b06d53b1767eed8a8ad3c87dfbb051fa8b4d74a7352e9abddc050f90c471b6459e4"} build_url:https://queue.taskcluster.net/v1/task/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011376 build_url: 'https://queue.taskcluster.net/v1/task/L4zBG0hPQtKvG3r3vO_OmA/artifacts/public/build/firefox-47.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/ed30cd78a6980c4eb78dd6522b0b56c15da65c0ba06fda3ca9f8a7d5fb49276362a97fdcfcfb1c3c37e3f01ba25be30a6d517b4e0731b7648f0d9e8f12a1a6ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2cbe05d2682c0d6f9d53190e922e86c80af6be3bdc922dbdcc030113d50e9b06d53b1767eed8a8ad3c87dfbb051fa8b4d74a7352e9abddc050f90c471b6459e4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-27 08:26:01.218077) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 08:26:01.218536) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1456587746.448507-749278510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 08:26:01.299895) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-27 08:26:01.303264) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-27 08:26:01.303611) ========= ========= Total master_lag: 0.31 =========