builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1447879717.9 results: success (0) buildid: 20151118113056 builduid: e5e592681ec246c7aba7095665dd327a revision: 929982f95a788e798b848da372725dd80cc44b36 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:37.904494) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:37.905020) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:37.905512) ========= 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=ccb4611811c763f2fad71465000001de-1447879702.74719-157360663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005904 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:37.930899) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:37.931367) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:37.949278) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:37.949558) ========= 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=ccb4611811c763f2fad71465000001de-1447879702.74719-157360663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004639 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:37.999627) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:38.000103) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:38.000720) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:38.001268) ========= 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=ccb4611811c763f2fad71465000001de-1447879702.74719-157360663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-18 12:48:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2015-11-18 12:48:38 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161973 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:38.180308) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:38.181022) ========= 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=ccb4611811c763f2fad71465000001de-1447879702.74719-157360663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015509 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:38.234469) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:38.235219) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 929982f95a788e798b848da372725dd80cc44b36 --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 929982f95a788e798b848da372725dd80cc44b36 --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=ccb4611811c763f2fad71465000001de-1447879702.74719-157360663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-18 12:48:38,592 truncating revision to first 12 chars 2015-11-18 12:48:38,592 Setting DEBUG logging. 2015-11-18 12:48:38,592 attempt 1/10 2015-11-18 12:48:38,592 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/929982f95a78?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 12:48:38,851 unpacking tar archive at: fx-team-929982f95a78/testing/mozharness/ program finished with exit code 0 elapsedTime=0.525180 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:38.780885) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:38.781257) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:38.791852) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:38.792459) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:38.793496) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-11-18 12:48:38.794202) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ccb4611811c763f2fad71465000001de-1447879702.74719-157360663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:48:39 INFO - MultiFileLogger online at 20151118 12:48:39 in /builds/slave/test-pgo 12:48:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:48:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 12:48:39 INFO - {'append_to_log': False, 12:48:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 12:48:39 INFO - 'blob_upload_branch': 'Fx-Team', 12:48:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 12:48:39 INFO - 'branch': 'Fx-Team', 12:48:39 INFO - 'buildbot_json_path': 'buildprops.json', 12:48:39 INFO - 'config_files': ('talos/linux_config.py',), 12:48:39 INFO - 'default_actions': ('clobber', 12:48:39 INFO - 'read-buildbot-config', 12:48:39 INFO - 'download-and-extract', 12:48:39 INFO - 'populate-webroot', 12:48:39 INFO - 'create-virtualenv', 12:48:39 INFO - 'install', 12:48:39 INFO - 'run-tests'), 12:48:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:48:39 INFO - 'download_minidump_stackwalk': True, 12:48:39 INFO - 'download_symbols': 'ondemand', 12:48:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:48:39 INFO - 'tooltool.py': '/tools/tooltool.py', 12:48:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:48:39 INFO - '/tools/misc-python/virtualenv.py')}, 12:48:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:48:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:48:39 INFO - 'installer_path': 'installer.exe', 12:48:39 INFO - 'log_level': 'info', 12:48:39 INFO - 'log_name': 'talos', 12:48:39 INFO - 'log_to_console': True, 12:48:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:48:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:48:39 INFO - 'opt_config_files': (), 12:48:39 INFO - 'pip_index': False, 12:48:39 INFO - 'sps_profile': False, 12:48:39 INFO - 'sps_profile_interval': 0, 12:48:39 INFO - 'suite': 'dromaeojs', 12:48:39 INFO - 'system_bits': '64', 12:48:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:48:39 INFO - 'title': 'talos-linux64-ix-021', 12:48:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:48:39 INFO - 'use_talos_json': True, 12:48:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 12:48:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:48:39 INFO - 'work_dir': 'build'} 12:48:39 INFO - ##### 12:48:39 INFO - ##### Running clobber step. 12:48:39 INFO - ##### 12:48:39 INFO - Running pre-action listener: _resource_record_pre_action 12:48:39 INFO - Running main action method: clobber 12:48:39 INFO - rmtree: /builds/slave/test-pgo/build 12:48:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 12:48:40 INFO - Running post-action listener: _resource_record_post_action 12:48:40 INFO - ##### 12:48:40 INFO - ##### Running read-buildbot-config step. 12:48:40 INFO - ##### 12:48:40 INFO - Running pre-action listener: _resource_record_pre_action 12:48:40 INFO - Running main action method: read_buildbot_config 12:48:40 INFO - Using buildbot properties: 12:48:40 INFO - { 12:48:40 INFO - "properties": { 12:48:40 INFO - "buildnumber": 497, 12:48:40 INFO - "product": "firefox", 12:48:40 INFO - "script_repo_revision": "production", 12:48:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:48:40 INFO - "repository": "", 12:48:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 12:48:40 INFO - "buildid": "20151118113056", 12:48:40 INFO - "slavename": "talos-linux64-ix-021", 12:48:40 INFO - "pgo_build": "True", 12:48:40 INFO - "basedir": "/builds/slave/test-pgo", 12:48:40 INFO - "project": "", 12:48:40 INFO - "platform": "ubuntu64_hw", 12:48:40 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:48:40 INFO - "slavebuilddir": "test", 12:48:40 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 12:48:40 INFO - "branch": "fx-team", 12:48:40 INFO - "repo_path": "integration/fx-team", 12:48:40 INFO - "stage_platform": "linux64-pgo", 12:48:40 INFO - "builduid": "e5e592681ec246c7aba7095665dd327a", 12:48:40 INFO - "revision": "929982f95a788e798b848da372725dd80cc44b36" 12:48:40 INFO - }, 12:48:40 INFO - "sourcestamp": { 12:48:40 INFO - "repository": "", 12:48:40 INFO - "hasPatch": false, 12:48:40 INFO - "project": "", 12:48:40 INFO - "branch": "fx-team-linux64-pgo-talos", 12:48:40 INFO - "changes": [ 12:48:40 INFO - { 12:48:40 INFO - "category": null, 12:48:40 INFO - "files": [ 12:48:40 INFO - { 12:48:40 INFO - "url": null, 12:48:40 INFO - "name": "https://queue.taskcluster.net/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 12:48:40 INFO - } 12:48:40 INFO - ], 12:48:40 INFO - "repository": "", 12:48:40 INFO - "rev": "929982f95a788e798b848da372725dd80cc44b36", 12:48:40 INFO - "who": "sendchange", 12:48:40 INFO - "when": 1447879664, 12:48:40 INFO - "number": 6678725, 12:48:40 INFO - "comments": "", 12:48:40 INFO - "project": "", 12:48:40 INFO - "at": "Wed 18 Nov 2015 12:47:44", 12:48:40 INFO - "branch": "fx-team-linux64-pgo-talos", 12:48:40 INFO - "revlink": "", 12:48:40 INFO - "properties": [ 12:48:40 INFO - [ 12:48:40 INFO - "buildid", 12:48:40 INFO - "20151118113056", 12:48:40 INFO - "Change" 12:48:40 INFO - ], 12:48:40 INFO - [ 12:48:40 INFO - "builduid", 12:48:40 INFO - "e5e592681ec246c7aba7095665dd327a", 12:48:40 INFO - "Change" 12:48:40 INFO - ], 12:48:40 INFO - [ 12:48:40 INFO - "pgo_build", 12:48:40 INFO - "True", 12:48:40 INFO - "Change" 12:48:40 INFO - ] 12:48:40 INFO - ], 12:48:40 INFO - "revision": "929982f95a788e798b848da372725dd80cc44b36" 12:48:40 INFO - } 12:48:40 INFO - ], 12:48:40 INFO - "revision": "929982f95a788e798b848da372725dd80cc44b36" 12:48:40 INFO - } 12:48:40 INFO - } 12:48:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 12:48:40 INFO - Running post-action listener: _resource_record_post_action 12:48:40 INFO - ##### 12:48:40 INFO - ##### Running download-and-extract step. 12:48:40 INFO - ##### 12:48:40 INFO - Running pre-action listener: _resource_record_pre_action 12:48:40 INFO - Running main action method: download_and_extract 12:48:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 12:48: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')]} 12:48:40 INFO - https://queue.taskcluster.net/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:48:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/test_packages.json 12:48:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/test_packages.json 12:48:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 12:48:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 12:48:44 INFO - Downloaded 1302 bytes. 12:48:44 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 12:48:44 INFO - Using the following test package requirements: 12:48:44 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:48:44 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:48:44 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:44 INFO - u'jsshell-linux-x86_64.zip'], 12:48:44 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:48:44 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:48:44 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:48:44 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:48:44 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:48:44 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:48:44 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:48:44 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:48:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:44 INFO - https://queue.taskcluster.net/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:48:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:48:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:48:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:48:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:48:48 INFO - Downloaded 22474411 bytes. 12:48:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 12:48:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:48:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 12:48:49 INFO - Return code: 0 12:48:49 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:48: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')]} 12:48:49 INFO - https://queue.taskcluster.net/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:48:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:48:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:48:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:48:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:49:00 INFO - Downloaded 22474411 bytes. 12:49:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 12:49:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:49:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 12:49:02 INFO - Return code: 0 12:49: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')]} 12:49:02 INFO - https://queue.taskcluster.net/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:49:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:49:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:49:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:49:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:49:03 INFO - Downloaded 11130997 bytes. 12:49:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 12:49:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:49:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 12:49:03 INFO - Return code: 0 12:49:03 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')]} 12:49:03 INFO - https://queue.taskcluster.net/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:49:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:49:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:49:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:49:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:49:04 INFO - Downloaded 57209136 bytes. 12:49:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:49:04 INFO - mkdir: /builds/slave/test-pgo/properties 12:49:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 12:49:04 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 12:49:04 INFO - Contents: 12:49:04 INFO - build_url:https://queue.taskcluster.net/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:49:04 INFO - Running post-action listener: _resource_record_post_action 12:49:04 INFO - Running post-action listener: set_extra_try_arguments 12:49:04 INFO - ##### 12:49:04 INFO - ##### Running populate-webroot step. 12:49:04 INFO - ##### 12:49:04 INFO - Running pre-action listener: _resource_record_pre_action 12:49:04 INFO - Running main action method: populate_webroot 12:49:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:49:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:49:04 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:49:04 INFO - '../fennec_ids.txt'], 12:49:04 INFO - 'tests': ['tcheck2']}, 12:49:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:49:04 INFO - '--tppagecycles', 12:49:04 INFO - '7'], 12:49:04 INFO - 'tests': ['tsvgm']}}, 12:49:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:49:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:49:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:49:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:49:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:49:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:49:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:49:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:49:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:49:04 INFO - 'talos_options': ['--e10s'], 12:49:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:49:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:49:04 INFO - 'tests': ['damp', 'tps']}, 12:49:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:49:04 INFO - 'talos_options': ['--e10s'], 12:49:04 INFO - 'tests': ['damp', 'tps']}, 12:49:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:49:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:49:04 INFO - 'other': {'tests': ['a11yr', 12:49:04 INFO - 'ts_paint', 12:49:04 INFO - 'tpaint', 12:49:04 INFO - 'sessionrestore', 12:49:04 INFO - 'sessionrestore_no_auto_restore']}, 12:49:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:49:04 INFO - 'tests': ['a11yr', 12:49:04 INFO - 'ts_paint', 12:49:04 INFO - 'tpaint', 12:49:04 INFO - 'sessionrestore', 12:49:04 INFO - 'sessionrestore_no_auto_restore']}, 12:49:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:49:04 INFO - 'tests': ['a11yr', 12:49:04 INFO - 'ts_paint', 12:49:04 INFO - 'tpaint', 12:49:04 INFO - 'sessionrestore', 12:49:04 INFO - 'sessionrestore_no_auto_restore']}, 12:49:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:49:04 INFO - 'tests': ['a11yr', 12:49:04 INFO - 'ts_paint', 12:49:04 INFO - 'tpaint', 12:49:04 INFO - 'sessionrestore', 12:49:04 INFO - 'sessionrestore_no_auto_restore']}, 12:49:04 INFO - 'other_l64': {'tests': ['a11yr', 12:49:04 INFO - 'ts_paint', 12:49:04 INFO - 'tpaint', 12:49:04 INFO - 'sessionrestore', 12:49:04 INFO - 'sessionrestore_no_auto_restore']}, 12:49:04 INFO - 'other_nol64': {'tests': ['a11yr', 12:49:04 INFO - 'ts_paint', 12:49:04 INFO - 'tpaint', 12:49:04 INFO - 'sessionrestore', 12:49:04 INFO - 'sessionrestore_no_auto_restore']}, 12:49:04 INFO - 'svgr': {'tests': ['tsvgx', 12:49:04 INFO - 'tsvgr_opacity', 12:49:04 INFO - 'tart', 12:49:04 INFO - 'tscrollx', 12:49:04 INFO - 'cart']}, 12:49:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:49:04 INFO - 'tests': ['tsvgx', 12:49:04 INFO - 'tsvgr_opacity', 12:49:04 INFO - 'tart', 12:49:04 INFO - 'tscrollx', 12:49:04 INFO - 'cart']}, 12:49:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:49:04 INFO - 'tests': ['tp5o']}, 12:49:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:49:04 INFO - 'talos_options': ['--e10s'], 12:49:04 INFO - 'tests': ['tp5o']}, 12:49:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:49:04 INFO - 'talos_options': ['--xperf_path', 12:49:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:49:04 INFO - 'tests': ['tp5n']}, 12:49:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:49:04 INFO - 'talos_options': ['--e10s', 12:49:04 INFO - '--xperf_path', 12:49:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:49:04 INFO - 'tests': ['tp5n']}}, 12:49:04 INFO - 'talos.zip': {'path': '', 12:49:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:49:04 INFO - Running post-action listener: _resource_record_post_action 12:49:04 INFO - ##### 12:49:04 INFO - ##### Running create-virtualenv step. 12:49:04 INFO - ##### 12:49:04 INFO - Running pre-action listener: _resource_record_pre_action 12:49:04 INFO - Running main action method: create_virtualenv 12:49:04 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 12:49:04 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 12:49:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 12:49:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:49:04 INFO - Using real prefix '/usr' 12:49:04 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 12:49:05 INFO - Installing distribute.............................................................................................................................................................................................done. 12:49:07 INFO - Installing pip.................done. 12:49:07 INFO - Return code: 0 12:49:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 12:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:49:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f6a02a5ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bf7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2403d70>, '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 0x2404b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2404fb0>, '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': 'ccb4611811c763f2fad71465000001de-1447879702.74719-157360663', '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 12:49:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 12:49:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:49:07 INFO - Using env: {'DISPLAY': ':0', 12:49:07 INFO - 'HOME': '/home/cltbld', 12:49:07 INFO - 'LANG': 'en_US.UTF-8', 12:49:07 INFO - 'LANGUAGE': 'en_US:en', 12:49:07 INFO - 'LOGNAME': 'cltbld', 12:49:07 INFO - 'MAIL': '/var/mail/cltbld', 12:49:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:07 INFO - 'MOZ_NO_REMOTE': '1', 12:49:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:07 INFO - 'NO_EM_RESTART': '1', 12:49:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:49:07 INFO - 'PWD': '/builds/slave/test-pgo', 12:49:07 INFO - 'SHELL': '/bin/bash', 12:49:07 INFO - 'SHLVL': '1', 12:49:07 INFO - 'TERM': 'linux', 12:49:07 INFO - 'TMOUT': '86400', 12:49:07 INFO - 'USER': 'cltbld', 12:49:07 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1447879702.74719-157360663', 12:49:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:07 INFO - '_': '/tools/buildbot/bin/python'} 12:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:07 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 12:49:07 INFO - Cleaning up... 12:49:07 INFO - Return code: 0 12:49:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 12:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:49:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f6a02a5ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bf7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2403d70>, '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 0x2404b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2404fb0>, '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': 'ccb4611811c763f2fad71465000001de-1447879702.74719-157360663', '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 12:49:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 12:49:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:49:07 INFO - Using env: {'DISPLAY': ':0', 12:49:07 INFO - 'HOME': '/home/cltbld', 12:49:07 INFO - 'LANG': 'en_US.UTF-8', 12:49:07 INFO - 'LANGUAGE': 'en_US:en', 12:49:07 INFO - 'LOGNAME': 'cltbld', 12:49:07 INFO - 'MAIL': '/var/mail/cltbld', 12:49:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:07 INFO - 'MOZ_NO_REMOTE': '1', 12:49:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:07 INFO - 'NO_EM_RESTART': '1', 12:49:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:49:07 INFO - 'PWD': '/builds/slave/test-pgo', 12:49:07 INFO - 'SHELL': '/bin/bash', 12:49:07 INFO - 'SHLVL': '1', 12:49:07 INFO - 'TERM': 'linux', 12:49:07 INFO - 'TMOUT': '86400', 12:49:07 INFO - 'USER': 'cltbld', 12:49:07 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1447879702.74719-157360663', 12:49:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:07 INFO - '_': '/tools/buildbot/bin/python'} 12:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:07 INFO - Downloading/unpacking psutil>=0.7.1 12:49: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 12:49: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 12:49: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 12:49: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 12:49: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 12:49: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 12:49:09 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 12:49:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:49:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 12:49:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:49:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:49:09 INFO - Installing collected packages: psutil 12:49:09 INFO - Running setup.py install for psutil 12:49:09 INFO - building 'psutil._psutil_linux' extension 12:49:09 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 12:49:09 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 12:49:09 INFO - building 'psutil._psutil_posix' extension 12:49:09 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 12:49:10 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 12:49:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:49:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:49:10 INFO - Successfully installed psutil 12:49:10 INFO - Cleaning up... 12:49:10 INFO - Return code: 0 12:49:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 12:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:49:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f6a02a5ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bf7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2403d70>, '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 0x2404b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2404fb0>, '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': 'ccb4611811c763f2fad71465000001de-1447879702.74719-157360663', '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 12:49:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 12:49:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:49:10 INFO - Using env: {'DISPLAY': ':0', 12:49:10 INFO - 'HOME': '/home/cltbld', 12:49:10 INFO - 'LANG': 'en_US.UTF-8', 12:49:10 INFO - 'LANGUAGE': 'en_US:en', 12:49:10 INFO - 'LOGNAME': 'cltbld', 12:49:10 INFO - 'MAIL': '/var/mail/cltbld', 12:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:10 INFO - 'MOZ_NO_REMOTE': '1', 12:49:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:10 INFO - 'NO_EM_RESTART': '1', 12:49:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:49:10 INFO - 'PWD': '/builds/slave/test-pgo', 12:49:10 INFO - 'SHELL': '/bin/bash', 12:49:10 INFO - 'SHLVL': '1', 12:49:10 INFO - 'TERM': 'linux', 12:49:10 INFO - 'TMOUT': '86400', 12:49:10 INFO - 'USER': 'cltbld', 12:49:10 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1447879702.74719-157360663', 12:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:10 INFO - '_': '/tools/buildbot/bin/python'} 12:49:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:49:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:49:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:49:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:49:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:49:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:49:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:49:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:49:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:49:12 INFO - Installing collected packages: mozsystemmonitor 12:49:12 INFO - Running setup.py install for mozsystemmonitor 12:49:12 INFO - Successfully installed mozsystemmonitor 12:49:12 INFO - Cleaning up... 12:49:12 INFO - Return code: 0 12:49:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 12:49:12 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')]} 12:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:12 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')]} 12:49:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6a02a5ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bf7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2403d70>, '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 0x2404b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2404fb0>, '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': 'ccb4611811c763f2fad71465000001de-1447879702.74719-157360663', '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 12:49:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 12:49:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:49:12 INFO - Using env: {'DISPLAY': ':0', 12:49:12 INFO - 'HOME': '/home/cltbld', 12:49:12 INFO - 'LANG': 'en_US.UTF-8', 12:49:12 INFO - 'LANGUAGE': 'en_US:en', 12:49:12 INFO - 'LOGNAME': 'cltbld', 12:49:12 INFO - 'MAIL': '/var/mail/cltbld', 12:49:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:12 INFO - 'MOZ_NO_REMOTE': '1', 12:49:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:12 INFO - 'NO_EM_RESTART': '1', 12:49:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:49:12 INFO - 'PWD': '/builds/slave/test-pgo', 12:49:12 INFO - 'SHELL': '/bin/bash', 12:49:12 INFO - 'SHLVL': '1', 12:49:12 INFO - 'TERM': 'linux', 12:49:12 INFO - 'TMOUT': '86400', 12:49:12 INFO - 'USER': 'cltbld', 12:49:12 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1447879702.74719-157360663', 12:49:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:12 INFO - '_': '/tools/buildbot/bin/python'} 12:49:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:12 INFO - Downloading/unpacking blobuploader==1.2.4 12:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:49:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:49:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:49:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:49:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:49:14 INFO - Downloading blobuploader-1.2.4.tar.gz 12:49:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:49:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:49:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:49:14 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 12:49:14 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 12:49:14 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 12:49:14 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 12:49:14 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 12:49:14 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 12:49:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:49:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 12:49:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:49:14 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 12:49:14 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 12:49:14 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 12:49:14 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 12:49:14 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 12:49:14 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 12:49:14 INFO - Downloading docopt-0.6.1.tar.gz 12:49:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:49:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 12:49:14 INFO - Installing collected packages: blobuploader, requests, docopt 12:49:14 INFO - Running setup.py install for blobuploader 12:49:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:49:15 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 12:49:15 INFO - Running setup.py install for requests 12:49:15 INFO - Running setup.py install for docopt 12:49:15 INFO - Successfully installed blobuploader requests docopt 12:49:15 INFO - Cleaning up... 12:49:15 INFO - Return code: 0 12:49:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:49:15 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')]} 12:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:15 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')]} 12:49:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6a02a5ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bf7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2403d70>, '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 0x2404b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2404fb0>, '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': 'ccb4611811c763f2fad71465000001de-1447879702.74719-157360663', '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 12:49:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 12:49:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:49:15 INFO - Using env: {'DISPLAY': ':0', 12:49:15 INFO - 'HOME': '/home/cltbld', 12:49:15 INFO - 'LANG': 'en_US.UTF-8', 12:49:15 INFO - 'LANGUAGE': 'en_US:en', 12:49:15 INFO - 'LOGNAME': 'cltbld', 12:49:15 INFO - 'MAIL': '/var/mail/cltbld', 12:49:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:15 INFO - 'MOZ_NO_REMOTE': '1', 12:49:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:15 INFO - 'NO_EM_RESTART': '1', 12:49:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:49:15 INFO - 'PWD': '/builds/slave/test-pgo', 12:49:15 INFO - 'SHELL': '/bin/bash', 12:49:15 INFO - 'SHLVL': '1', 12:49:15 INFO - 'TERM': 'linux', 12:49:15 INFO - 'TMOUT': '86400', 12:49:15 INFO - 'USER': 'cltbld', 12:49:15 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1447879702.74719-157360663', 12:49:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:15 INFO - '_': '/tools/buildbot/bin/python'} 12:49:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:49:15 INFO - Running setup.py (path:/tmp/pip-QGMpvJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:49:15 INFO - Running setup.py (path:/tmp/pip-kZVyay-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:49:15 INFO - Running setup.py (path:/tmp/pip-MXj8t_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:49:15 INFO - Running setup.py (path:/tmp/pip-wC0eAE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:49:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:49:16 INFO - Running setup.py (path:/tmp/pip-pl692j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:49:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:49:16 INFO - Running setup.py (path:/tmp/pip-0q_IAf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:49:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:49:16 INFO - Running setup.py (path:/tmp/pip-4xeYTP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:49:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:49:16 INFO - Running setup.py (path:/tmp/pip-ddv89R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:49:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:49:16 INFO - Running setup.py (path:/tmp/pip-f8Eg5e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:49:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:49:16 INFO - Running setup.py (path:/tmp/pip-iX8aKX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:49:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:49:16 INFO - Running setup.py (path:/tmp/pip-wf_8JB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:49:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:49:16 INFO - Running setup.py (path:/tmp/pip-CNJVfF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:49:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:49:16 INFO - Running setup.py (path:/tmp/pip-iBMwQ7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:49:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:49:16 INFO - Running setup.py (path:/tmp/pip-totv7F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:49:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:49:16 INFO - Running setup.py (path:/tmp/pip-DTNOwo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:49:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:49:16 INFO - Running setup.py (path:/tmp/pip-pgS1Gc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:49:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:49:16 INFO - Running setup.py (path:/tmp/pip-Fjnx16-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:49:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:49:16 INFO - Running setup.py install for manifestparser 12:49:17 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 12:49:17 INFO - Running setup.py install for mozcrash 12:49:17 INFO - Running setup.py install for mozdebug 12:49:17 INFO - Running setup.py install for mozdevice 12:49:17 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 12:49:17 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 12:49:17 INFO - Running setup.py install for mozfile 12:49:17 INFO - Running setup.py install for mozhttpd 12:49:17 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 12:49:17 INFO - Running setup.py install for mozinfo 12:49:17 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 12:49:17 INFO - Running setup.py install for mozInstall 12:49:17 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 12:49:17 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 12:49:17 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 12:49:17 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 12:49:17 INFO - Running setup.py install for mozleak 12:49:17 INFO - Running setup.py install for mozlog 12:49:17 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 12:49:18 INFO - Running setup.py install for moznetwork 12:49:18 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 12:49:18 INFO - Running setup.py install for mozprocess 12:49:18 INFO - Running setup.py install for mozprofile 12:49:18 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 12:49:18 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 12:49:18 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 12:49:18 INFO - Running setup.py install for mozrunner 12:49:18 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 12:49:18 INFO - Running setup.py install for mozscreenshot 12:49:18 INFO - Running setup.py install for moztest 12:49:18 INFO - Running setup.py install for mozversion 12:49:18 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 12:49:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:49:18 INFO - Cleaning up... 12:49:18 INFO - Return code: 0 12:49:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:49:18 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')]} 12:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:18 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')]} 12:49:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6a02a5ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bf7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2403d70>, '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 0x2404b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2404fb0>, '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': 'ccb4611811c763f2fad71465000001de-1447879702.74719-157360663', '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 12:49:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 12:49:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:49:18 INFO - Using env: {'DISPLAY': ':0', 12:49:18 INFO - 'HOME': '/home/cltbld', 12:49:18 INFO - 'LANG': 'en_US.UTF-8', 12:49:18 INFO - 'LANGUAGE': 'en_US:en', 12:49:18 INFO - 'LOGNAME': 'cltbld', 12:49:18 INFO - 'MAIL': '/var/mail/cltbld', 12:49:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:18 INFO - 'MOZ_NO_REMOTE': '1', 12:49:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:18 INFO - 'NO_EM_RESTART': '1', 12:49:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:49:18 INFO - 'PWD': '/builds/slave/test-pgo', 12:49:18 INFO - 'SHELL': '/bin/bash', 12:49:18 INFO - 'SHLVL': '1', 12:49:18 INFO - 'TERM': 'linux', 12:49:18 INFO - 'TMOUT': '86400', 12:49:18 INFO - 'USER': 'cltbld', 12:49:18 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1447879702.74719-157360663', 12:49:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:18 INFO - '_': '/tools/buildbot/bin/python'} 12:49:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:49:18 INFO - Running setup.py (path:/tmp/pip-VjO_2I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:49:19 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)) 12:49:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:49:19 INFO - Running setup.py (path:/tmp/pip-7lbdoR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:49:19 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)) 12:49:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:49:19 INFO - Running setup.py (path:/tmp/pip-RTtDiM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:49:19 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)) 12:49:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:49:19 INFO - Running setup.py (path:/tmp/pip-QHBArP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:49:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 12:49:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:49:19 INFO - Running setup.py (path:/tmp/pip-F5hnFK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:49:19 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)) 12:49:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:49:19 INFO - Running setup.py (path:/tmp/pip-f8teLQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:49:19 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)) 12:49:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:49:19 INFO - Running setup.py (path:/tmp/pip-hngba8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:49:19 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)) 12:49:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:49:19 INFO - Running setup.py (path:/tmp/pip-LuOZ5y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:49:19 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)) 12:49:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:49:19 INFO - Running setup.py (path:/tmp/pip-lHFrGN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:49:19 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)) 12:49:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:49:19 INFO - Running setup.py (path:/tmp/pip-8jWDvC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:49:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 12:49:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:49:19 INFO - Running setup.py (path:/tmp/pip-KnHeH7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:49:19 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)) 12:49:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:49:19 INFO - Running setup.py (path:/tmp/pip-oWWKcX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:49:19 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)) 12:49:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:49:19 INFO - Running setup.py (path:/tmp/pip-wcO__Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:49:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 12:49:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:49:19 INFO - Running setup.py (path:/tmp/pip-bSRYjl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:49:20 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)) 12:49:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:49:20 INFO - Running setup.py (path:/tmp/pip-x_UKVi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:49:20 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)) 12:49:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:49:20 INFO - Running setup.py (path:/tmp/pip-PY5Qjt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:49:20 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)) 12:49:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:49:20 INFO - Running setup.py (path:/tmp/pip-vyqetW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:49:20 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)) 12:49:20 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)) 12:49:20 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)) 12:49:20 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)) 12:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 12:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 12:49:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:49:20 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 12:49:20 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 12:49:20 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 12:49:20 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 12:49:20 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 12:49:20 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 12:49:21 INFO - Downloading blessings-1.5.1.tar.gz 12:49:21 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 12:49:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 12:49:21 INFO - Installing collected packages: blessings 12:49:21 INFO - Running setup.py install for blessings 12:49:22 INFO - Successfully installed blessings 12:49:22 INFO - Cleaning up... 12:49:22 INFO - Return code: 0 12:49:22 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 12:49:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:49:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:49:22 INFO - Reading from file tmpfile_stdout 12:49:22 INFO - Current package versions: 12:49:22 INFO - argparse == 1.2.1 12:49:22 INFO - blessings == 1.5.1 12:49:22 INFO - blobuploader == 1.2.4 12:49:22 INFO - docopt == 0.6.1 12:49:22 INFO - manifestparser == 1.1 12:49:22 INFO - mozInstall == 1.12 12:49:22 INFO - mozcrash == 0.16 12:49:22 INFO - mozdebug == 0.1 12:49:22 INFO - mozdevice == 0.47 12:49:22 INFO - mozfile == 1.2 12:49:22 INFO - mozhttpd == 0.7 12:49:22 INFO - mozinfo == 0.9 12:49:22 INFO - mozleak == 0.1 12:49:22 INFO - mozlog == 3.0 12:49:22 INFO - moznetwork == 0.27 12:49:22 INFO - mozprocess == 0.22 12:49:22 INFO - mozprofile == 0.27 12:49:22 INFO - mozrunner == 6.11 12:49:22 INFO - mozscreenshot == 0.1 12:49:22 INFO - mozsystemmonitor == 0.0 12:49:22 INFO - moztest == 0.7 12:49:22 INFO - mozversion == 1.4 12:49:22 INFO - psutil == 3.1.1 12:49:22 INFO - requests == 1.2.3 12:49:22 INFO - wsgiref == 0.1.2 12:49:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:49:22 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')]} 12:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:22 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')]} 12:49:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:22 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6a02a5ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bf7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2403d70>, '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 0x2404b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2404fb0>, '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': 'ccb4611811c763f2fad71465000001de-1447879702.74719-157360663', '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 12:49:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 12:49:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:49:22 INFO - Using env: {'DISPLAY': ':0', 12:49:22 INFO - 'HOME': '/home/cltbld', 12:49:22 INFO - 'LANG': 'en_US.UTF-8', 12:49:22 INFO - 'LANGUAGE': 'en_US:en', 12:49:22 INFO - 'LOGNAME': 'cltbld', 12:49:22 INFO - 'MAIL': '/var/mail/cltbld', 12:49:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:22 INFO - 'MOZ_NO_REMOTE': '1', 12:49:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:22 INFO - 'NO_EM_RESTART': '1', 12:49:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:49:22 INFO - 'PWD': '/builds/slave/test-pgo', 12:49:22 INFO - 'SHELL': '/bin/bash', 12:49:22 INFO - 'SHLVL': '1', 12:49:22 INFO - 'TERM': 'linux', 12:49:22 INFO - 'TMOUT': '86400', 12:49:22 INFO - 'USER': 'cltbld', 12:49:22 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1447879702.74719-157360663', 12:49:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:22 INFO - '_': '/tools/buildbot/bin/python'} 12:49:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:22 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 1)) 12:49:22 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 2)) 12:49:22 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 3)) 12:49:22 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 4)) 12:49:22 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 5)) 12:49:22 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 6)) 12:49:22 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 7)) 12:49:22 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 8)) 12:49:22 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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 12:49:22 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 3)) 12:49:22 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 12:49:22 INFO - Cleaning up... 12:49:22 INFO - Return code: 0 12:49:22 INFO - Running post-action listener: _resource_record_post_action 12:49:22 INFO - Running post-action listener: _start_resource_monitoring 12:49:22 INFO - Starting resource monitoring. 12:49:22 INFO - ##### 12:49:22 INFO - ##### Running install step. 12:49:22 INFO - ##### 12:49:22 INFO - Running pre-action listener: _resource_record_pre_action 12:49:22 INFO - Running main action method: install 12:49:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:49:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:49:22 INFO - Reading from file tmpfile_stdout 12:49:22 INFO - Detecting whether we're running mozinstall >=1.0... 12:49:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 12:49:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 12:49:22 INFO - Reading from file tmpfile_stdout 12:49:22 INFO - Output received: 12:49:22 INFO - Usage: mozinstall [options] installer 12:49:22 INFO - Options: 12:49:22 INFO - -h, --help show this help message and exit 12:49:22 INFO - -d DEST, --destination=DEST 12:49:22 INFO - Directory to install application into. [default: 12:49:22 INFO - "/builds/slave/test-pgo"] 12:49:22 INFO - --app=APP Application being installed. [default: firefox] 12:49:22 INFO - mkdir: /builds/slave/test-pgo/build/application 12:49:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 12:49:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 12:49:37 INFO - Reading from file tmpfile_stdout 12:49:37 INFO - Output received: 12:49:37 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 12:49:37 INFO - Running post-action listener: _resource_record_post_action 12:49:37 INFO - ##### 12:49:37 INFO - ##### Running run-tests step. 12:49:37 INFO - ##### 12:49:37 INFO - Running pre-action listener: _resource_record_pre_action 12:49:37 INFO - Running main action method: run_tests 12:49:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 12:49:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 12:49:37 INFO - Python 2.7.3 12:49:37 INFO - Return code: 0 12:49:37 INFO - grabbing minidump binary from tooltool 12:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:49:37 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 0x2403d70>, '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 0x2404b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2404fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 12:49:37 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 12:49:37 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 12:49:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:49:37 INFO - Return code: 0 12:49:37 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 12:49:37 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 12:49:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 12:49:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 12:49:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 12:49:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 12:49:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost 12:49:37 INFO - Using env: {'DISPLAY': ':0', 12:49:37 INFO - 'HOME': '/home/cltbld', 12:49:37 INFO - 'LANG': 'en_US.UTF-8', 12:49:37 INFO - 'LANGUAGE': 'en_US:en', 12:49:37 INFO - 'LOGNAME': 'cltbld', 12:49:37 INFO - 'MAIL': '/var/mail/cltbld', 12:49:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:49:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 12:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:37 INFO - 'MOZ_NO_REMOTE': '1', 12:49:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:37 INFO - 'NO_EM_RESTART': '1', 12:49:37 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:49:37 INFO - 'PWD': '/builds/slave/test-pgo', 12:49:37 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 12:49:37 INFO - 'SHELL': '/bin/bash', 12:49:37 INFO - 'SHLVL': '1', 12:49:37 INFO - 'TERM': 'linux', 12:49:37 INFO - 'TMOUT': '86400', 12:49:37 INFO - 'USER': 'cltbld', 12:49:37 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1447879702.74719-157360663', 12:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:37 INFO - '_': '/tools/buildbot/bin/python'} 12:49:37 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost'] with output_timeout 3600 12:49:38 INFO - mozversion INFO | application_buildid: 20151118113056 12:49:38 INFO - mozversion INFO | application_changeset: 929982f95a788e798b848da372725dd80cc44b36 12:49:38 INFO - mozversion INFO | application_display_name: Nightly 12:49:38 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:49:38 INFO - mozversion INFO | application_name: Firefox 12:49:38 INFO - mozversion INFO | application_remotingname: firefox 12:49:38 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 12:49:38 INFO - mozversion INFO | application_vendor: Mozilla 12:49:38 INFO - mozversion INFO | application_version: 45.0a1 12:49:38 INFO - mozversion INFO | platform_buildid: 20151118113056 12:49:38 INFO - mozversion INFO | platform_changeset: 929982f95a788e798b848da372725dd80cc44b36 12:49:38 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 12:49:38 INFO - mozversion INFO | platform_version: 45.0a1 12:49:38 INFO - 2015-11-18 12:49:38,079 DEBUG : using testdate: 1447879778 12:49:38 INFO - 2015-11-18 12:49:38,080 DEBUG : actual date: 1447879778 12:49:38 INFO - 2015-11-18 12:49:38,127 INFO : starting webserver on 'localhost:59629' 12:49:38 INFO - 2015-11-18 12:49:38,128 INFO : Starting test suite talos-linux64-ix-021 12:49:38 INFO - 2015-11-18 12:49:38,128 INFO : Starting test dromaeo_css 12:49:38 INFO - 2015-11-18 12:49:38,128 DEBUG : operating with platform_type : linux_ 12:49:38 INFO - 2015-11-18 12:49:38,129 INFO : Initialising browser for dromaeo_css test... 12:49:38 INFO - 2015-11-18 12:49:38,140 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprro_cN/profile http://localhost:59629/getInfo.html 12:49:46 INFO - 2015-11-18 12:49:46,849 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:49:46 INFO - 2015-11-18 12:49:46,849 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:49:46 INFO - 2015-11-18 12:49:46,849 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:49:46 INFO - 2015-11-18 12:49:46,849 DEBUG : BROWSER_OUTPUT: __metrics 12:49:47 INFO - 2015-11-18 12:49:47,119 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:49:48 INFO - 2015-11-18 12:49:48,861 INFO : Browser initialized. 12:49:48 INFO - 2015-11-18 12:49:48,861 INFO : Running cycle 1/1 for dromaeo_css test... 12:49:48 INFO - 2015-11-18 12:49:48,862 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprro_cN/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:50:00 INFO - 2015-11-18 12:50:00,686 DEBUG : BROWSER_OUTPUT: RSS: Main: 139767808 12:50:00 INFO - 2015-11-18 12:50:00,687 DEBUG : BROWSER_OUTPUT: 12:50:52 INFO - 2015-11-18 12:50:52,161 DEBUG : BROWSER_OUTPUT: 1447879852158 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] 12:53:01 INFO - 2015-11-18 12:53:01,047 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59629/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59629/tests/dromaeo/cssquery-ext.html) 12:53:02 INFO - 2015-11-18 12:53:02,217 DEBUG : BROWSER_OUTPUT: RSS: Main: 265760768 12:53:02 INFO - 2015-11-18 12:53:02,217 DEBUG : BROWSER_OUTPUT: 12:56:04 INFO - 2015-11-18 12:56:04,643 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59629/tests/dromaeo/cssquery-ext.html (next: http://localhost:59629/tests/dromaeo/cssquery-jquery.html) 12:56:05 INFO - 2015-11-18 12:56:05,214 DEBUG : BROWSER_OUTPUT: RSS: Main: 224661504 12:56:05 INFO - 2015-11-18 12:56:05,214 DEBUG : BROWSER_OUTPUT: 12:59:07 INFO - 2015-11-18 12:59:07,073 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59629/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59629/tests/dromaeo/cssquery-mootools.html) 12:59:07 INFO - 2015-11-18 12:59:07,655 DEBUG : BROWSER_OUTPUT: RSS: Main: 215011328 12:59:07 INFO - 2015-11-18 12:59:07,655 DEBUG : BROWSER_OUTPUT: 13:02:09 INFO - 2015-11-18 13:02:09,509 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59629/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59629/tests/dromaeo/cssquery-prototype.html) 13:02:10 INFO - 2015-11-18 13:02:10,091 DEBUG : BROWSER_OUTPUT: RSS: Main: 203055104 13:02:10 INFO - 2015-11-18 13:02:10,091 DEBUG : BROWSER_OUTPUT: 13:05:12 INFO - 2015-11-18 13:05:12,540 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59629/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59629/tests/dromaeo/cssquery-yui.html) 13:05:13 INFO - 2015-11-18 13:05:13,106 DEBUG : BROWSER_OUTPUT: RSS: Main: 205590528 13:05:13 INFO - 2015-11-18 13:05:13,106 DEBUG : BROWSER_OUTPUT: 13:08:15 INFO - 2015-11-18 13:08:15,545 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59629/tests/dromaeo/cssquery-yui.html (next: http://localhost:59629/tests/dromaeo/cssquery-dojo.html) 13:08:15 INFO - 2015-11-18 13:08:15,795 DEBUG : BROWSER_OUTPUT: RSS: Main: 252420096 13:08:15 INFO - 2015-11-18 13:08:15,796 DEBUG : BROWSER_OUTPUT: 13:08:15 INFO - 2015-11-18 13:08:15,796 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:08:15 INFO - 2015-11-18 13:08:15,796 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:08:15 INFO - 2015-11-18 13:08:15,796 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:08:15 INFO - 2015-11-18 13:08:15,798 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:08:15 INFO - 2015-11-18 13:08:15,798 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3137.2313783123136;3215.4212241796467;3252.414565378231;3254;3274.001429563982;5105.897882042357;5181.911798522315;5296.470352964707;5297.152455607104;5317;5211.400688920775;5284.445133261001;5328.706921119337;5358.785648574052;5384.0847056000475;4906.190478571031;4960.751962401883;4982.427020892589;4989.600831933455;5018.5232402921665;5015.724135172564;5038;5088.720120393377;5103.132467480537;5107.259447380127;4780.545848144421;4842.322074909515;4895.534924182197;4926.827561035347;4930.260460930853;4899.951000489985;4906.239532872411;4909.533594308535;4912.828051018233;4933.284673722326;4877.146499362633;4889.657723959324;4893.804247830082;4904.803807847682;4944.8269310574315;5017.147084995523;5120.1039818031695;5126.102931986925;5141.203113517374;5151.896962060775;5700.37295897451;5715.2855893013375;5716.1711551825165;5767.452092051249;5814.447627475383;5764.423557644244;5787.652740835521;5803.21656576361;5804.680742559158;5808.273965754281;5229.47705229474;5410.702411367373;5414;5414.7834086636485;5417.972910135463;5683.914741278884;5729.455701708331;5730.885382292331;5765.85585360361;5781.71091445426;5611.354694210137;5612.663240205601;5660.943390566124;5665.830025099253;5671.716414179275;5587.944120558824;5671.631343962629;5677.772889084473;5688.431156884279;5706.144078388192;5597.692126933058;5634.661920284796;5658.066419040812;5680.11958146488;5712.028955077647;5667.858303542362;5710.057840456361;5710.428957104256;5719.113537401709;5720.885582288331;4308;4319.827206911751;4422.49141348749;4444.82220711168;4477.059817438309;3936.9803150984635;3952.3478626026385;3956.9010774730864;3982.7212095153063;3991.1419044904906;5461.2354270402175;5462.180672899097;5471.863203419866;5477.507024367746;5501.229827824108;5504.339479262434;5612.214289999403;5772.538196944319;5811.15738217956;5918.822435326947;5408.864778380572;5421.539169170585;5427.48438898304;5428.75570599324;5480.588955828329;5000.449950505442;5011.423686276052;5052.090623687698;5052.418971818214;5112.642115051911;5682.204491371212;5822.388649191858;5823;5928.9110663339225;5946.286445626466;5738.770449181986;5739.655620662774;5750.568707346882;5752.763155921497;5756.453136951983;5781.537477001913;5858.150568167677;5864.179014937998;5865.266841644794;5867.882642347215;5612.01789686795;5635.8591035224445;5703.372629010722;5709.25779648643;5747.540196784331;5784.50831679312;5792.7103644818435;5793.304803423616;5836.795712150054;5844.824655260179;5417.052015897281;5534.225208470898;5632.85917852057;5639.182318563703;5640.492355687844;5404.486573775485;5451.318585176853;5451.427600102091;5462.481064298885;5499;5489.094299440707;5491.505764481056;5492.340919089735;5492.945070549403;5517.062099443185;5400.9459905400445;5440.727963601883;5514.420985796433;5603.327600687943;5643.746031428514;5405.8107966221;5426.294581704353;5474.151506516497;5578.693171875586;5606.355269144101 13:08:15 INFO - 2015-11-18 13:08:15,799 DEBUG : BROWSER_OUTPUT: |1;ext.html;545.2294828507987;584.7660935625751;590.9793157239492;595.0716881664604;613.0742578706155;31104.68895311049;39743.20513589727;40556.188876222455;40602;40608.59391406085;42575;43058.56941430585;43110.353344699855;43122.35316470255;43143.568564314344;7633.274838890325;7778;7787.922120778805;8784.956075219616;8966.596503157341;10742.409167495785;11004.614838480655;11007.61473348433;11021.944890275538;11028.338299702003;10503.264771466;10531.789364212711;10624.840627390595;10625.20310976676;10629.681109566725;7662.540247585135;7742.690292388298;10535.47322633869;10762.246642735012;11049.944750276198;10377.584896604127;10515.94742026285;10536.420496872668;10536.420496872668;10537.525811338508;38841.805790970866;39080;39225.41161882574;39265.803670981746;39295.21409571821;3213.271038267667;3322.96677033229;3386.4243078676436;3402.2515046689687;3453.620101788801;29334.559981600294;29710.771692123177;29877;29986;30706.078817635283;3571.2500374921296;3580.3197392495345;3607.134287770942;3667.1015601177614;3760.417135344026;251847;252435;252852;252948;253112;56172.43827561754;57274.42725572691;57741;64266.67866660637;65379.67310163419;59041.40958590359;59106.40893591009;59209;59286.70356648189;59299.407005930254;15881.841181588035;16142.19289035567;16170.353185872433;16178.19109044543;16200.67598648044;12183.329916854658;12249.265044097383;12278.079144064232;12313.56902508408;12351.814722779165;19154;19156;19222.327218547285;19344.129514171895;19441.611167776566;7531.548107113591;7712.575808330484;7731.149573547018;7769.145394006655;7821.452498325177;915.4004127296631;927.5408672706918;939.1688355805026;974.2400927276594;1100.6973082402403;25295.873520632278;25352.366190845376;25416.237512874643;28842.567361489593;29380.559291610214;996.5615129343211;1036.6268143468346;1046.4558429616557;1049.9317544359592;1141.668916014363;15017.624559386102;15863.20683965797;15967.44113956006;16003.439879604159;16370.181490925406;320244;323290;324271;324393;324652;51734.74132629313;51842.74078629583;51850.48149518456;51858.22212666813;51984.74007629938;1371.1156304183746;1372.7391795558813;1374.615107769826;1382.979255311171;1388.7083712420506;22215;27982.3004424891;29964.70035299619;30543.54184687187;30644.233894152825;46573.767131164124;46799.76600116977;46915;47016.29475557938;47060;273397;275335;275480;275645;275779;31738.682613174497;31884.681153188172;32303.51544726878;32562.837185813918;32717.18207044843;39428;41106;42144.36783448312;42276.36585451282;43361.56638433701;35369.292614148086;35865.46201806923;35920.820395898896;35979.82010089933;36164;30677;34282.314353713286;36122;36370.27259454849;36820;33083.17292067718;33208.833955830065;33217;33294;33303.33393332071;28851;30242.395152096396;31588.842055789573;32744.836275818467;32851.50722739209;24785.10099633921;24840.875795620905;24853.234824281004;25018.499630007664;25121.49757004886 13:08:15 INFO - 2015-11-18 13:08:15,800 DEBUG : BROWSER_OUTPUT: |2;jquery.html;354.30556110024366;354.46298857231295;359.1882345898269;360.866479402621;363.69449662283677;13777.380017899193;13957.79063314051;16717.916410417947;16740.246688899013;17254.913725431372;15183.468578599724;15786.289616967235;15795.289211985459;16262.51212463628;16328.591785205375;5183.196604526304;5313.362396512424;5315.14957606783;5316.680999140064;5318.25544423781;3971;4102.753834769908;5239.659422137568;5297.073012222865;5651.717414129298;5709.086546152616;5733.397993210715;5777.855553611173;5784.363719990798;5792.768289268424;5472.370677372093;5708.71456427177;5710.486056254957;5717.599768016241;5756.625819321752;5024.9748751256375;5031.949680503185;5037.722925239111;5039.899202015976;5040.470750571174;20600.175992960263;20847.37457876266;21063.262785802577;21165.68251476214;21266.893665531574;2122.628540005493;2140.529083601605;2168.2086038595958;2209.4807720185745;2258.654272463249;12764.17032892859;13037.348132593332;13105.410256538478;13193.538226162038;13329.005842113069;1582.1326076935668;1765.6645237404853;1774.6273282610666;1777.8844375115575;1870.3734249026593;56170;56622;57267;57498;57569.712151439395;9265.861012084824;9447.574859131355;9706.174975127053;9761.658341957997;9818.459984700767;12615.93692031534;12621.495140194289;12628.116031877864;12631.936840315924;12633.684157895943;5517.2551705520045;5595.860103497445;5626.831195064155;5784.681842498619;7558.168601453835;5492.752826122834;5815.098659707752;5918.141869428909;5961.523078153824;5962.701864906824;3304.686054824788;3334.449815780369;3340.1315657929113;3359.4792807114936;3360.445526488102;1125.8460078419685;1159.6984783956232;1163.8021536338842;1208.6523526268322;1218.0620921890095;478.8826737449347;488.7482946282667;489.60831334932624;500.7696459628539;515.9742012899341;11337.829932551018;11981.64055078349;12330.383480825923;12366.876331236752;12393;511.08770844043204;514.2466286889725;520.3183829183781;521.9712915789668;551.2447946313576;6407.615543067338;6671.86656266872;6686;6703.592245628375;6760;551311;553470;557731;557920;560280;68673.31326686768;71067;71948;72623.27376726165;72998;548.2105767694508;571.4799532425556;571.5113577890844;572.6449601247253;572.9054705973467;10770.838437423601;10960.177986651193;11176.764647070457;11245.606403776155;11255.606053788078;33387.499187512694;33526.32947340991;33667.494987575694;34781.47827782535;34787.13032174216;46370.7681461604;46689.2996605058;46783;47819.52180478151;48155;6945.791626251221;6992.741306564867;7052.294770522906;7070.469714771516;7071.646417679199;11885.16803823724;12497.12520123619;12542.12205145631;12559.120861539604;12561.62315130511;8533.530655813742;9247.861282080908;9254.953725231331;9536.713898583053;10789;10566.366018038942;10586.4706764663;10741.67774966721;10750.51622676997;10892.237543371888;10839.512221949873;10947.726306842393;11213.327200368005;11264.324140551593;11265.887341126483;6591.802245932629;6691.029800678777;6720.596764194164;6968.581885086911;7031.507794454339;10888.510017049093;10910.61812836547;11195.2723073;11201.551937922392;11224.887751122711 13:08:15 INFO - 2015-11-18 13:08:15,801 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1340.6447291467769;1706.8634509239262;1754.6490701859632;1778.7065134252846;1792.5877048278896;6915.343042410976;7177.85644287114;7378.299061589147;7485.401167906554;7517.24827517248;7576.128745194291;7613.543187408759;7620.580868052255;7634.160242373348;7638.732644357448;1920.7407000055023;1960.1963195090016;2191.244020812817;2197.1540956731615;2209.2930262316067;2167.4364665187086;2223.5775202711516;2224.710787597618;2225;2225.2656623314347;2079.324219628619;2120.8303335733103;2122.352682431858;2125.1393185759716;2138.9893050534724;1801.3695206677558;1844.5204246895837;1854.1192933356683;1878.398912348056;2159.6220661384273;2166.2851259084464;2171.359448962544;2172.0660116150048;2172.1637169689784;2172.6197915364905;7455.589942553157;7590.278923502258;7590.316871481593;7609.315161635479;7609.961950190269;4672.789724462374;4700.482946875841;4737.952620473786;4755.2153894607345;4760.381150450419;3188.601424821897;3205.951910721341;3241.9675803241903;3252.983735081333;3253.1704415374165;1020.7090979070929;1037.8495118207893;1038.8234000219904;1063.8616979792655;1068.8076146293663;10780.676579702622;10796.028357447867;10803.729906752316;10816.891831081668;10841.83737243942;4306.095719898856;4371.038371558252;4418.955810441918;4463.910721785611;4467.508574056851;9285.907140928639;9286.860697089549;9293.442393456415;9300.255979521622;9311;4836.153673107192;4856.854294371175;4868.780904859219;4869.9513004870205;4870.6103511718975;4393.626541743924;4395.428594282723;4397.362382454527;4398.846040388571;4399.076193999232;3693.741438099361;3737.9065523362133;3745.3071181830906;3765.4728338032696;3784.280986612535;1146.2606618730872;1146.4497041420166;1158.0793269350886;1162.9825552616717;1163.1741463560797;1258.6035398849333;1269.5746924780117;1277.2974863824859;1318.6241921052647;1319.089828018664;7338.926610733931;7358.77923662291;7402.666879990414;7415.85168296631;7464.738734144279;478.6027597094403;483.9806407743651;486.9440014398389;506.2558039681662;506.3872714016008;4914.950850491521;6010.308814486302;6081.483073938764;6114.174586430775;6115.113308570232;9305.860412093823;9371.625134994523;9412.905870941204;9416.05839416053;9453.858192127123;9120.315976301805;9238.307126965505;9267.21228695555;9290.303227257848;9330.766730831649;7121.465890058163;7197.388222001188;7204.423646108299;7227.530210536298;7293.197748247689;6938.826529336807;7249.601271930094;7276.126864776261;7294.051773269441;7301.817454563678;7870.842583148419;8085.353171746128;8197.590120493833;8323.458975166595;8343.499390036617;8179.304759095544;8186.549739764132;8201.343892488705;8216.507009579444;8273.586320683822;6991.335823096798;7094.077769889881;7104;7107.893381599177;7110.928890711233;7474.177840437439;7578.621068946421;7644.694212231449;7653.043369578802;7656.73201437947;6998.16022077354;7015.719371225298;7129.82175445618;7158.128196931005;7297.781066568012;6944;7018.192907815666;7032.894506582303;7096.929030709627;7137.10786151731;7144.3570078693165;7165.426765858823;7177.995080688604;7190.640467976685;7208.783736487913;6540.37866402691;6545.541812073109;6604.5046621502615;6646.368594983469;6650.301718319701;6494.577852439576;6540.542162048611;6586.868262634624;6590.1103351046995;6604 13:08:15 INFO - 2015-11-18 13:08:15,805 DEBUG : BROWSER_OUTPUT: |4;prototype.html;342.9914252143696;345.28870526714985;348.99127521811954;349.6555892445942;353.7064236683553;5945.286565612128;6054.334023257438;6058.515318774498;6087.543434242428;6095;5719.714014299289;5791.768329266834;5873.941260587393;5948.286205655317;5959.225300710901;4582.541745825424;4605.815767369301;4606.424196975369;4624.05206932578;4629.791659375336;4412.933805992912;4607.493175750665;4620.075984803036;4626.606738427237;4631.907361852761;4448.888777780549;4454.37638730578;4528.026474308023;4541.636669066484;4575.771211439432;4519.909601807945;4554.681172317939;4565.954340456587;4569.885752856172;4572.657050721209;4040.8383664653675;4044.5955404459614;4044.6562042226446;4047.150098479323;4047.3119569673227;5525.640833345819;5634.183043458716;5644.887102257973;5657.745401456903;5658.264425624642;5318.840434786963;5357.8392648220615;5367.758450869681;5371.838844834661;5378.677279363251;6281.905771413432;6282.560220784547;6289.371062893674;6291.496680265568;6291.559590828644;4498.910021799578;4504.707194032378;4505.43682039745;4507.030988337523;4519.028408892071;6399.584027038274;6543.836404089889;6545.476361891085;6550.7707230246715;6588.604683718992;4418.873187337208;4461.174682683714;4472.798724057425;4474.463064432289;4480.439945006874;4527.501974782771;4544.250198717241;4546.408966834357;4550.8850331668955;4551.226291530448;5255.290535777697;5258.447862974409;5263.815766448156;5265;5268.789248430096;6228.56400051992;6382.680865956683;6424.453921416732;6425.550211485244;6430.196225471816;1581.841815818409;1618.7248167811501;1619.1175809184024;1621.2704283072665;1621.4000819696553;1078.223678951154;1078.9352638841538;1084.5336505302637;1099.6536091131268;1104.3705088099707;6176.598521096114;6192.969035154795;6195.690215489208;6199.163112979781;6203.720832562545;6598.769043083469;6600.471962243009;6607.603543787388;6608.570442921195;6610.173728283965;5968.850778730566;6083.239595050619;6141.96929015361;6211.09939058834;6252.531060170505;3557.1640664443835;3557.1996300832625;3558.91102722434;3566.768160069639;3579.266250418658;6803.285655006153;6838.589684618939;6845.657717114224;6853.725850965906;6869.828254293583;6653.367930046637;6757.155355580552;6821.4542836572955;6823.590584564942;6825.55633883796;6779.93220067793;6790.0493930849725;6790.660466976631;6793.218779840283;6793.93206067933;6531.706073226621;6630.204375474974;6633.071370008106;6636.568623039487;6649.73401063952;6547.508936829852;6561.540692151503;6566;6566.9343306568235;6568.244651865097;6811.114555107804;6824.385805277549;6825.35159159879;6827.829304267433;6841.555298905555;4504.887377815581;4507.864764057083;4509.909801804011;4510.594046535827;4515.503294637653;6452.935470645421;6627.304133065959;6627.9337206627315;6656.167979002625;6661.666916654245;6455.0962865199845;6457.515686323639;6460.644664543495;6464.09502669636;6475.255345635313;6412.807615771534;6439.034144878306;6454.677266136769;6460.967695161494;6464.2889282177985;6117.082437634391;6275.6862156892885;6306.590071645328;6332.683365831782;6339.080833279241;6436.420722135031;6450.516211284266;6455.515836312389;6461.967690161519;6473.708683109366;6183.166436809207;6308.463780578702;6318.589291696025;6324.620522768649;6324.873502529832 13:08:15 INFO - 2015-11-18 13:08:15,805 DEBUG : BROWSER_OUTPUT: |5;yui.html;773.1147835728095;823.2261674026411;840.1304649687573;842.5450256861295;846.1327139681828;13763.65590860229;14078.507252246174;14095.436182552685;14138.787918181222;14736.926315368408;14162.78755818661;14545.127292362438;14547.199904005276;14564.708705825877;14571.708565828678;671.07056726434;684.6918886501095;812.9796755081111;819.2381085590414;835.7826964989116;822.284612387224;825.0511911301991;830.0122853803985;830.0827585517976;831.8170002599448;867.7960679240374;874.7419511244199;874.9475031498099;875.0068672057197;875.6628697951303;699.9475039372041;701.3617607976743;845.7716416567523;859.7721603775004;861.0700443520982;625.368377938281;628.7704987679509;632.905064240363;633.0946746152999;633.1484153813115;13146.60560183196;13259.110829056792;13278.336083195802;13320.600381988555;13362.933185334012;10041.297109202358;10511.264211505199;10514.684559463229;10658;10935.070519005894;9674;9931.404115753077;10073.143782778472;10312.175025997902;10374.429406382646;3267.9346413071844;3348.4809854472596;3349.7152742016956;3409.215880347509;3435.519027336175;46141.30788038182;46223.07553848938;46749.76625116887;47155.764221179015;47323;7238.055468559709;7375.262473752582;7378.151512576015;7381.11426628808;7524.661390237453;12460.937695311466;12490.188137771016;12495.187812792139;12513.249205047545;12518.624441266777;6938.826529336807;6950.270221626656;6976.407005404496;7046.048783414276;7130.964345178345;4187.24629566681;4259.169461954951;4319.67602429819;4336.132773445323;4350.956490435118;2812.5078111330436;2854.1437568729298;2881.63122516807;2889.508783506809;2897.4350001749876;453.2770231480783;463.55730277584826;464.25023586907577;466.80160931603933;467.31771613444073;496.32747626965664;648.9188851393576;664.8005598320581;667.033386359014;680.9489288303298;8592.44149130317;8921.821563568692;8950.23922966555;8961.103889610988;9141.268698504104;570.3697414357158;617.7343742190811;655.2464665634558;664.4750646988824;682.1813823411926;4115.650169735606;4176.937345939813;4206.558311377323;4266.957330426656;4321.805518751664;56971.43028569744;58040.70979645159;62415.68792156101;62725;63057.36942630607;50078;50528.74735626298;51336.74331628318;51559.48440515547;57212;50071;50319.49680503148;50695.239571406455;50781.23828142581;52450.47549524456;8548.572571371282;8926.553672316228;8931.910680893108;8946.507942063248;9037.322200834833;35603.64396356003;35864.28271434505;36365.81817091003;36401;36893.81553092218;45413.772931135136;45646.54353456423;46091;46639.76680116577;46773;11267.830982535432;11538.653840384803;11792.941035294769;12178.451969661564;12196.146269761386;12599.559015434415;12876.420561074587;12913.548025819051;12947.189097103708;13341.266230357423;11110.555577776799;11126.165537584551;11552.191346605992;11582.88417115818;12219.144659873724;11585.7103572408;11800.822987655363;12020.158588898694;12036.75926481483;12455.750884982432;11525.308481491138;11809.763804724029;11878.168528202943;12003.279803211835;12302.446389912655;9072.682456114004;9199.678011269574;9356.906430935604;9394.483303418378;9595.328327017041;8776.254018408506;8968.68609598661;9393.214246706051;9636.662716805158;9860.408375497493 13:08:15 INFO - 2015-11-18 13:08:15,805 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:08:15 INFO - 2015-11-18 13:08:15,805 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:08:15 INFO - 2015-11-18 13:08:15,805 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,952 13:08:15 INFO - 2015-11-18 13:08:15,805 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:08:15 INFO - 2015-11-18 13:08:15,805 DEBUG : BROWSER_OUTPUT: __startTimestamp1447880895795__endTimestamp 13:08:15 INFO - 2015-11-18 13:08:15,806 DEBUG : BROWSER_OUTPUT: 13:08:15 INFO - 2015-11-18 13:08:15,806 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:08:15 INFO - 2015-11-18 13:08:15,806 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:08:15 INFO - 2015-11-18 13:08:15,806 DEBUG : BROWSER_OUTPUT: 13:08:15 INFO - 2015-11-18 13:08:15,806 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5316.78 Median:5477.51 stddev:568.02 (10.4%) stddev-sans-first:543.42 13:08:15 INFO - 2015-11-18 13:08:15,806 DEBUG : BROWSER_OUTPUT: Values: 3137.2 3215.4 3252.4 3254.0 3274.0 5105.9 5181.9 5296.5 5297.2 5317.0 5211.4 5284.4 5328.7 5358.8 5384.1 4906.2 4960.8 4982.4 4989.6 5018.5 5015.7 5038.0 5088.7 5103.1 5107.3 4780.5 4842.3 4895.5 4926.8 4930.3 4900.0 4906.2 4909.5 4912.8 4933.3 4877.1 4889.7 4893.8 4904.8 4944.8 5017.1 5120.1 5126.1 5141.2 5151.9 5700.4 5715.3 5716.2 5767.5 5814.4 5764.4 5787.7 5803.2 5804.7 5808.3 5229.5 5410.7 5414.0 5414.8 5418.0 5683.9 5729.5 5730.9 5765.9 5781.7 5611.4 5612.7 5660.9 5665.8 5671.7 5587.9 5671.6 5677.8 5688.4 5706.1 5597.7 5634.7 5658.1 5680.1 5712.0 5667.9 5710.1 5710.4 5719.1 5720.9 4308.0 4319.8 4422.5 4444.8 4477.1 3937.0 3952.3 3956.9 3982.7 3991.1 5461.2 5462.2 5471.9 5477.5 5501.2 5504.3 5612.2 5772.5 5811.2 5918.8 5408.9 5421.5 5427.5 5428.8 5480.6 5000.4 5011.4 5052.1 5052.4 5112.6 5682.2 5822.4 5823.0 5928.9 5946.3 5738.8 5739.7 5750.6 5752.8 5756.5 5781.5 5858.2 5864.2 5865.3 5867.9 5612.0 5635.9 5703.4 5709.3 5747.5 5784.5 5792.7 5793.3 5836.8 5844.8 5417.1 5534.2 5632.9 5639.2 5640.5 5404.5 5451.3 5451.4 5462.5 5499.0 5489.1 5491.5 5492.3 5492.9 5517.1 5400.9 5440.7 5514.4 5603.3 5643.7 5405.8 5426.3 5474.2 5578.7 5606.4 13:08:15 INFO - 2015-11-18 13:08:15,806 DEBUG : BROWSER_OUTPUT: 13:08:15 INFO - 2015-11-18 13:08:15,806 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45581.50 Median:324522.50 stddev:74414.19 (22.9%) stddev-sans-first:74546.12 13:08:15 INFO - 2015-11-18 13:08:15,806 DEBUG : BROWSER_OUTPUT: Values: 545.2 584.8 591.0 595.1 613.1 31104.7 39743.2 40556.2 40602.0 40608.6 42575.0 43058.6 43110.4 43122.4 43143.6 7633.3 7778.0 7787.9 8785.0 8966.6 10742.4 11004.6 11007.6 11021.9 11028.3 10503.3 10531.8 10624.8 10625.2 10629.7 7662.5 7742.7 10535.5 10762.2 11049.9 10377.6 10515.9 10536.4 10536.4 10537.5 38841.8 39080.0 39225.4 39265.8 39295.2 3213.3 3323.0 3386.4 3402.3 3453.6 29334.6 29710.8 29877.0 29986.0 30706.1 3571.3 3580.3 3607.1 3667.1 3760.4 251847.0 252435.0 252852.0 252948.0 253112.0 56172.4 57274.4 57741.0 64266.7 65379.7 59041.4 59106.4 59209.0 59286.7 59299.4 15881.8 16142.2 16170.4 16178.2 16200.7 12183.3 12249.3 12278.1 12313.6 12351.8 19154.0 19156.0 19222.3 19344.1 19441.6 7531.5 7712.6 7731.1 7769.1 7821.5 915.4 927.5 939.2 974.2 1100.7 25295.9 25352.4 25416.2 28842.6 29380.6 996.6 1036.6 1046.5 1049.9 1141.7 15017.6 15863.2 15967.4 16003.4 16370.2 320244.0 323290.0 324271.0 324393.0 324652.0 51734.7 51842.7 51850.5 51858.2 51984.7 1371.1 1372.7 1374.6 1383.0 1388.7 22215.0 27982.3 29964.7 30543.5 30644.2 46573.8 46799.8 46915.0 47016.3 47060.0 273397.0 275335.0 275480.0 275645.0 275779.0 31738.7 31884.7 32303.5 32562.8 32717.2 39428.0 41106.0 42144.4 42276.4 43361.6 35369.3 35865.5 35920.8 35979.8 36164.0 30677.0 34282.3 36122.0 36370.3 36820.0 33083.2 33208.8 33217.0 33294.0 33303.3 28851.0 30242.4 31588.8 32744.8 32851.5 24785.1 24840.9 24853.2 25018.5 25121.5 13:08:15 INFO - 2015-11-18 13:08:15,806 DEBUG : BROWSER_OUTPUT: 13:08:15 INFO - 2015-11-18 13:08:15,806 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27804.18 Median:23630.94 stddev:90903.60 (384.7%) stddev-sans-first:91135.23 13:08:15 INFO - 2015-11-18 13:08:15,808 DEBUG : BROWSER_OUTPUT: Values: 354.3 354.5 359.2 360.9 363.7 13777.4 13957.8 16717.9 16740.2 17254.9 15183.5 15786.3 15795.3 16262.5 16328.6 5183.2 5313.4 5315.1 5316.7 5318.3 3971.0 4102.8 5239.7 5297.1 5651.7 5709.1 5733.4 5777.9 5784.4 5792.8 5472.4 5708.7 5710.5 5717.6 5756.6 5025.0 5031.9 5037.7 5039.9 5040.5 20600.2 20847.4 21063.3 21165.7 21266.9 2122.6 2140.5 2168.2 2209.5 2258.7 12764.2 13037.3 13105.4 13193.5 13329.0 1582.1 1765.7 1774.6 1777.9 1870.4 56170.0 56622.0 57267.0 57498.0 57569.7 9265.9 9447.6 9706.2 9761.7 9818.5 12615.9 12621.5 12628.1 12631.9 12633.7 5517.3 5595.9 5626.8 5784.7 7558.2 5492.8 5815.1 5918.1 5961.5 5962.7 3304.7 3334.4 3340.1 3359.5 3360.4 1125.8 1159.7 1163.8 1208.7 1218.1 478.9 488.7 489.6 500.8 516.0 11337.8 11981.6 12330.4 12366.9 12393.0 511.1 514.2 520.3 522.0 551.2 6407.6 6671.9 6686.0 6703.6 6760.0 551311.0 553470.0 557731.0 557920.0 560280.0 68673.3 71067.0 71948.0 72623.3 72998.0 548.2 571.5 571.5 572.6 572.9 10770.8 10960.2 11176.8 11245.6 11255.6 33387.5 33526.3 33667.5 34781.5 34787.1 46370.8 46689.3 46783.0 47819.5 48155.0 6945.8 6992.7 7052.3 7070.5 7071.6 11885.2 12497.1 12542.1 12559.1 12561.6 8533.5 9247.9 9255.0 9536.7 10789.0 10566.4 10586.5 10741.7 10750.5 10892.2 10839.5 10947.7 11213.3 11264.3 11265.9 6591.8 6691.0 6720.6 6968.6 7031.5 10888.5 10910.6 11195.3 11201.6 11224.9 13:08:15 INFO - 2015-11-18 13:08:15,808 DEBUG : BROWSER_OUTPUT: 13:08:15 INFO - 2015-11-18 13:08:15,808 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5443.84 Median:6517.48 stddev:2850.25 (43.7%) stddev-sans-first:2841.56 13:08:15 INFO - 2015-11-18 13:08:15,809 DEBUG : BROWSER_OUTPUT: Values: 1340.6 1706.9 1754.6 1778.7 1792.6 6915.3 7177.9 7378.3 7485.4 7517.2 7576.1 7613.5 7620.6 7634.2 7638.7 1920.7 1960.2 2191.2 2197.2 2209.3 2167.4 2223.6 2224.7 2225.0 2225.3 2079.3 2120.8 2122.4 2125.1 2139.0 1801.4 1844.5 1854.1 1878.4 2159.6 2166.3 2171.4 2172.1 2172.2 2172.6 7455.6 7590.3 7590.3 7609.3 7610.0 4672.8 4700.5 4738.0 4755.2 4760.4 3188.6 3206.0 3242.0 3253.0 3253.2 1020.7 1037.8 1038.8 1063.9 1068.8 10780.7 10796.0 10803.7 10816.9 10841.8 4306.1 4371.0 4419.0 4463.9 4467.5 9285.9 9286.9 9293.4 9300.3 9311.0 4836.2 4856.9 4868.8 4870.0 4870.6 4393.6 4395.4 4397.4 4398.8 4399.1 3693.7 3737.9 3745.3 3765.5 3784.3 1146.3 1146.4 1158.1 1163.0 1163.2 1258.6 1269.6 1277.3 1318.6 1319.1 7338.9 7358.8 7402.7 7415.9 7464.7 478.6 484.0 486.9 506.3 506.4 4915.0 6010.3 6081.5 6114.2 6115.1 9305.9 9371.6 9412.9 9416.1 9453.9 9120.3 9238.3 9267.2 9290.3 9330.8 7121.5 7197.4 7204.4 7227.5 7293.2 6938.8 7249.6 7276.1 7294.1 7301.8 7870.8 8085.4 8197.6 8323.5 8343.5 8179.3 8186.5 8201.3 8216.5 8273.6 6991.3 7094.1 7104.0 7107.9 7110.9 7474.2 7578.6 7644.7 7653.0 7656.7 6998.2 7015.7 7129.8 7158.1 7297.8 6944.0 7018.2 7032.9 7096.9 7137.1 7144.4 7165.4 7178.0 7190.6 7208.8 6540.4 6545.5 6604.5 6646.4 6650.3 6494.6 6540.5 6586.9 6590.1 6604.0 13:08:15 INFO - 2015-11-18 13:08:15,809 DEBUG : BROWSER_OUTPUT: 13:08:15 INFO - 2015-11-18 13:08:15,809 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5337.74 Median:6091.27 stddev:1612.11 (26.5%) stddev-sans-first:1572.44 13:08:15 INFO - 2015-11-18 13:08:15,809 DEBUG : BROWSER_OUTPUT: Values: 343.0 345.3 349.0 349.7 353.7 5945.3 6054.3 6058.5 6087.5 6095.0 5719.7 5791.8 5873.9 5948.3 5959.2 4582.5 4605.8 4606.4 4624.1 4629.8 4412.9 4607.5 4620.1 4626.6 4631.9 4448.9 4454.4 4528.0 4541.6 4575.8 4519.9 4554.7 4566.0 4569.9 4572.7 4040.8 4044.6 4044.7 4047.2 4047.3 5525.6 5634.2 5644.9 5657.7 5658.3 5318.8 5357.8 5367.8 5371.8 5378.7 6281.9 6282.6 6289.4 6291.5 6291.6 4498.9 4504.7 4505.4 4507.0 4519.0 6399.6 6543.8 6545.5 6550.8 6588.6 4418.9 4461.2 4472.8 4474.5 4480.4 4527.5 4544.3 4546.4 4550.9 4551.2 5255.3 5258.4 5263.8 5265.0 5268.8 6228.6 6382.7 6424.5 6425.6 6430.2 1581.8 1618.7 1619.1 1621.3 1621.4 1078.2 1078.9 1084.5 1099.7 1104.4 6176.6 6193.0 6195.7 6199.2 6203.7 6598.8 6600.5 6607.6 6608.6 6610.2 5968.9 6083.2 6142.0 6211.1 6252.5 3557.2 3557.2 3558.9 3566.8 3579.3 6803.3 6838.6 6845.7 6853.7 6869.8 6653.4 6757.2 6821.5 6823.6 6825.6 6779.9 6790.0 6790.7 6793.2 6793.9 6531.7 6630.2 6633.1 6636.6 6649.7 6547.5 6561.5 6566.0 6566.9 6568.2 6811.1 6824.4 6825.4 6827.8 6841.6 4504.9 4507.9 4509.9 4510.6 4515.5 6452.9 6627.3 6627.9 6656.2 6661.7 6455.1 6457.5 6460.6 6464.1 6475.3 6412.8 6439.0 6454.7 6461.0 6464.3 6117.1 6275.7 6306.6 6332.7 6339.1 6436.4 6450.5 6455.5 6462.0 6473.7 6183.2 6308.5 6318.6 6324.6 6324.9 13:08:15 INFO - 2015-11-18 13:08:15,809 DEBUG : BROWSER_OUTPUT: 13:08:15 INFO - 2015-11-18 13:08:15,809 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13885.25 Median:46964.38 stddev:16591.86 (35.3%) stddev-sans-first:16609.19 13:08:15 INFO - 2015-11-18 13:08:15,810 DEBUG : BROWSER_OUTPUT: Values: 773.1 823.2 840.1 842.5 846.1 13763.7 14078.5 14095.4 14138.8 14736.9 14162.8 14545.1 14547.2 14564.7 14571.7 671.1 684.7 813.0 819.2 835.8 822.3 825.1 830.0 830.1 831.8 867.8 874.7 874.9 875.0 875.7 699.9 701.4 845.8 859.8 861.1 625.4 628.8 632.9 633.1 633.1 13146.6 13259.1 13278.3 13320.6 13362.9 10041.3 10511.3 10514.7 10658.0 10935.1 9674.0 9931.4 10073.1 10312.2 10374.4 3267.9 3348.5 3349.7 3409.2 3435.5 46141.3 46223.1 46749.8 47155.8 47323.0 7238.1 7375.3 7378.2 7381.1 7524.7 12460.9 12490.2 12495.2 12513.2 12518.6 6938.8 6950.3 6976.4 7046.0 7131.0 4187.2 4259.2 4319.7 4336.1 4351.0 2812.5 2854.1 2881.6 2889.5 2897.4 453.3 463.6 464.3 466.8 467.3 496.3 648.9 664.8 667.0 680.9 8592.4 8921.8 8950.2 8961.1 9141.3 570.4 617.7 655.2 664.5 682.2 4115.7 4176.9 4206.6 4267.0 4321.8 56971.4 58040.7 62415.7 62725.0 63057.4 50078.0 50528.7 51336.7 51559.5 57212.0 50071.0 50319.5 50695.2 50781.2 52450.5 8548.6 8926.6 8931.9 8946.5 9037.3 35603.6 35864.3 36365.8 36401.0 36893.8 45413.8 45646.5 46091.0 46639.8 46773.0 11267.8 11538.7 11792.9 12178.5 12196.1 12599.6 12876.4 12913.5 12947.2 13341.3 11110.6 11126.2 11552.2 11582.9 12219.1 11585.7 11800.8 12020.2 12036.8 12455.8 11525.3 11809.8 11878.2 12003.3 12302.4 9072.7 9199.7 9356.9 9394.5 9595.3 8776.3 8968.7 9393.2 9636.7 9860.4 13:08:15 INFO - 2015-11-18 13:08:15,810 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:08:15 INFO - 2015-11-18 13:08:15,810 DEBUG : BROWSER_OUTPUT: 13:08:16 INFO - 2015-11-18 13:08:16,576 INFO : Browser exited with error code: 0 13:08:16 INFO - 2015-11-18 13:08:16,592 INFO : Completed test dromaeo_css (00:18:38) 13:08:16 INFO - 2015-11-18 13:08:16,592 INFO : Starting test kraken 13:08:16 INFO - 2015-11-18 13:08:16,592 DEBUG : operating with platform_type : linux_ 13:08:16 INFO - 2015-11-18 13:08:16,593 INFO : Initialising browser for kraken test... 13:08:16 INFO - 2015-11-18 13:08:16,598 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyU3Lxt/profile http://localhost:59629/getInfo.html 13:08:21 INFO - 2015-11-18 13:08:21,220 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:08:21 INFO - 2015-11-18 13:08:21,220 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:08:21 INFO - 2015-11-18 13:08:21,220 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:08:21 INFO - 2015-11-18 13:08:21,220 DEBUG : BROWSER_OUTPUT: __metrics 13:08:21 INFO - 2015-11-18 13:08:21,329 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:08:22 INFO - 2015-11-18 13:08:22,968 INFO : Browser initialized. 13:08:22 INFO - 2015-11-18 13:08:22,968 INFO : Running cycle 1/1 for kraken test... 13:08:22 INFO - 2015-11-18 13:08:22,969 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyU3Lxt/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:08:34 INFO - 2015-11-18 13:08:34,788 DEBUG : BROWSER_OUTPUT: RSS: Main: 140173312 13:08:34 INFO - 2015-11-18 13:08:34,788 DEBUG : BROWSER_OUTPUT: 13:08:37 INFO - 2015-11-18 13:08:37,247 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59629/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59629/tests/kraken/driver.html?testName=audio-beat-detection) 13:08:37 INFO - 2015-11-18 13:08:37,833 DEBUG : BROWSER_OUTPUT: RSS: Main: 178860032 13:08:37 INFO - 2015-11-18 13:08:37,833 DEBUG : BROWSER_OUTPUT: 13:08:40 INFO - 2015-11-18 13:08:40,415 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59629/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59629/tests/kraken/driver.html?testName=audio-dft) 13:08:40 INFO - 2015-11-18 13:08:40,988 DEBUG : BROWSER_OUTPUT: RSS: Main: 169172992 13:08:40 INFO - 2015-11-18 13:08:40,988 DEBUG : BROWSER_OUTPUT: 13:08:43 INFO - 2015-11-18 13:08:43,887 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59629/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59629/tests/kraken/driver.html?testName=audio-fft) 13:08:44 INFO - 2015-11-18 13:08:44,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 150765568 13:08:44 INFO - 2015-11-18 13:08:44,437 DEBUG : BROWSER_OUTPUT: 13:08:46 INFO - 2015-11-18 13:08:46,415 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59629/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59629/tests/kraken/driver.html?testName=audio-oscillator) 13:08:46 INFO - 2015-11-18 13:08:46,982 DEBUG : BROWSER_OUTPUT: RSS: Main: 155398144 13:08:46 INFO - 2015-11-18 13:08:46,982 DEBUG : BROWSER_OUTPUT: 13:08:49 INFO - 2015-11-18 13:08:49,142 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59629/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59629/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:08:49 INFO - 2015-11-18 13:08:49,703 DEBUG : BROWSER_OUTPUT: RSS: Main: 156446720 13:08:49 INFO - 2015-11-18 13:08:49,703 DEBUG : BROWSER_OUTPUT: 13:08:52 INFO - 2015-11-18 13:08:52,622 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59629/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59629/tests/kraken/driver.html?testName=imaging-darkroom) 13:08:53 INFO - 2015-11-18 13:08:53,191 DEBUG : BROWSER_OUTPUT: RSS: Main: 156643328 13:08:53 INFO - 2015-11-18 13:08:53,191 DEBUG : BROWSER_OUTPUT: 13:08:56 INFO - 2015-11-18 13:08:56,558 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59629/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59629/tests/kraken/driver.html?testName=imaging-desaturate) 13:08:57 INFO - 2015-11-18 13:08:57,132 DEBUG : BROWSER_OUTPUT: RSS: Main: 156307456 13:08:57 INFO - 2015-11-18 13:08:57,132 DEBUG : BROWSER_OUTPUT: 13:08:59 INFO - 2015-11-18 13:08:59,874 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59629/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59629/tests/kraken/driver.html?testName=json-parse-financial) 13:09:00 INFO - 2015-11-18 13:09:00,444 DEBUG : BROWSER_OUTPUT: RSS: Main: 157282304 13:09:00 INFO - 2015-11-18 13:09:00,444 DEBUG : BROWSER_OUTPUT: 13:09:01 INFO - 2015-11-18 13:09:01,999 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59629/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59629/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:09:02 INFO - 2015-11-18 13:09:02,560 DEBUG : BROWSER_OUTPUT: RSS: Main: 167079936 13:09:02 INFO - 2015-11-18 13:09:02,560 DEBUG : BROWSER_OUTPUT: 13:09:04 INFO - 2015-11-18 13:09:04,375 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59629/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59629/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:09:04 INFO - 2015-11-18 13:09:04,969 DEBUG : BROWSER_OUTPUT: RSS: Main: 166883328 13:09:04 INFO - 2015-11-18 13:09:04,969 DEBUG : BROWSER_OUTPUT: 13:09:07 INFO - 2015-11-18 13:09:07,020 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59629/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59629/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:09:07 INFO - 2015-11-18 13:09:07,593 DEBUG : BROWSER_OUTPUT: RSS: Main: 175661056 13:09:07 INFO - 2015-11-18 13:09:07,593 DEBUG : BROWSER_OUTPUT: 13:09:10 INFO - 2015-11-18 13:09:10,008 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59629/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59629/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:09:10 INFO - 2015-11-18 13:09:10,581 DEBUG : BROWSER_OUTPUT: RSS: Main: 182415360 13:09:10 INFO - 2015-11-18 13:09:10,582 DEBUG : BROWSER_OUTPUT: 13:09:13 INFO - 2015-11-18 13:09:13,149 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59629/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59629/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:09:13 INFO - 2015-11-18 13:09:13,715 DEBUG : BROWSER_OUTPUT: RSS: Main: 179843072 13:09:13 INFO - 2015-11-18 13:09:13,715 DEBUG : BROWSER_OUTPUT: 13:09:15 INFO - 2015-11-18 13:09:15,396 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59629/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59629/tests/kraken/driver.html?testName=ai-astar) 13:09:15 INFO - 2015-11-18 13:09:15,654 DEBUG : BROWSER_OUTPUT: RSS: Main: 238739456 13:09:15 INFO - 2015-11-18 13:09:15,654 DEBUG : BROWSER_OUTPUT: 13:09:15 INFO - 2015-11-18 13:09:15,654 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:09:15 INFO - 2015-11-18 13:09:15,654 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:09:15 INFO - 2015-11-18 13:09:15,654 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:09:15 INFO - 2015-11-18 13:09:15,655 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:09:15 INFO - 2015-11-18 13:09:15,655 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;104;110;109;110;119;112;110;111;109 13:09:15 INFO - 2015-11-18 13:09:15,655 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;146;123;155;162;125;147;150;131;160;123 13:09:15 INFO - 2015-11-18 13:09:15,655 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;164;161;160;159;159;163;161;161 13:09:15 INFO - 2015-11-18 13:09:15,655 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;81;95;71;71;72;110;90;73 13:09:15 INFO - 2015-11-18 13:09:15,655 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;91;133;89;90;90;134;90;91;134 13:09:15 INFO - 2015-11-18 13:09:15,655 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;110;109;109;109;109;109;109 13:09:15 INFO - 2015-11-18 13:09:15,655 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;146;146;145;147;145;146;147;146 13:09:15 INFO - 2015-11-18 13:09:15,656 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;96;96;97;96;96;96;96 13:09:15 INFO - 2015-11-18 13:09:15,656 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;58;59;59;58;58;57;65;55;55 13:09:15 INFO - 2015-11-18 13:09:15,656 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;69;69;70;69;70;70;69 13:09:15 INFO - 2015-11-18 13:09:15,656 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;85;87;84;85;85;84;84;85;84 13:09:15 INFO - 2015-11-18 13:09:15,656 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;117;117;113;121;119;121;118;120;115 13:09:15 INFO - 2015-11-18 13:09:15,656 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;141;150;151;150;140;151;150;151;142 13:09:15 INFO - 2015-11-18 13:09:15,657 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;68;76;66;69;69;67;67;68;68 13:09:15 INFO - 2015-11-18 13:09:15,657 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:09:15 INFO - 2015-11-18 13:09:15,657 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:09:15 INFO - 2015-11-18 13:09:15,657 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,901 13:09:15 INFO - 2015-11-18 13:09:15,657 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:09:15 INFO - 2015-11-18 13:09:15,657 DEBUG : BROWSER_OUTPUT: __startTimestamp1447880955649__endTimestamp 13:09:15 INFO - 2015-11-18 13:09:15,657 DEBUG : BROWSER_OUTPUT: 13:09:15 INFO - 2015-11-18 13:09:15,659 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:09:15 INFO - 2015-11-18 13:09:15,659 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:09:15 INFO - 2015-11-18 13:09:15,659 DEBUG : BROWSER_OUTPUT: 13:09:15 INFO - 2015-11-18 13:09:15,659 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.50 Median:110.50 stddev:3.69 (3.3%) stddev-sans-first:3.91 13:09:15 INFO - 2015-11-18 13:09:15,659 DEBUG : BROWSER_OUTPUT: Values: 111.0 104.0 110.0 109.0 110.0 119.0 112.0 110.0 111.0 109.0 13:09:15 INFO - 2015-11-18 13:09:15,660 DEBUG : BROWSER_OUTPUT: 13:09:15 INFO - 2015-11-18 13:09:15,660 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.20 Median:148.50 stddev:15.38 (10.4%) stddev-sans-first:16.25 13:09:15 INFO - 2015-11-18 13:09:15,660 DEBUG : BROWSER_OUTPUT: Values: 146.0 123.0 155.0 162.0 125.0 147.0 150.0 131.0 160.0 123.0 13:09:15 INFO - 2015-11-18 13:09:15,660 DEBUG : BROWSER_OUTPUT: 13:09:15 INFO - 2015-11-18 13:09:15,660 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.60 (1.0%) stddev-sans-first:1.66 13:09:15 INFO - 2015-11-18 13:09:15,660 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 164.0 161.0 160.0 159.0 159.0 163.0 161.0 161.0 13:09:15 INFO - 2015-11-18 13:09:15,660 DEBUG : BROWSER_OUTPUT: 13:09:15 INFO - 2015-11-18 13:09:15,660 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.70 Median:72.50 stddev:13.43 (18.5%) stddev-sans-first:13.87 13:09:15 INFO - 2015-11-18 13:09:15,660 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 81.0 95.0 71.0 71.0 72.0 110.0 90.0 73.0 13:09:15 INFO - 2015-11-18 13:09:15,660 DEBUG : BROWSER_OUTPUT: 13:09:15 INFO - 2015-11-18 13:09:15,661 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.30 Median:90.00 stddev:20.97 (23.3%) stddev-sans-first:21.76 13:09:15 INFO - 2015-11-18 13:09:15,661 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 133.0 89.0 90.0 90.0 134.0 90.0 91.0 134.0 13:09:15 INFO - 2015-11-18 13:09:15,661 DEBUG : BROWSER_OUTPUT: 13:09:15 INFO - 2015-11-18 13:09:15,661 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:09:15 INFO - 2015-11-18 13:09:15,661 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 13:09:15 INFO - 2015-11-18 13:09:15,661 DEBUG : BROWSER_OUTPUT: 13:09:15 INFO - 2015-11-18 13:09:15,661 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 13:09:15 INFO - 2015-11-18 13:09:15,661 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 146.0 146.0 145.0 147.0 145.0 146.0 147.0 146.0 13:09:15 INFO - 2015-11-18 13:09:15,661 DEBUG : BROWSER_OUTPUT: 13:09:15 INFO - 2015-11-18 13:09:15,661 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 13:09:15 INFO - 2015-11-18 13:09:15,662 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 13:09:15 INFO - 2015-11-18 13:09:15,662 DEBUG : BROWSER_OUTPUT: 13:09:15 INFO - 2015-11-18 13:09:15,663 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.20 Median:58.00 stddev:2.78 (4.8%) stddev-sans-first:2.95 13:09:15 INFO - 2015-11-18 13:09:15,663 DEBUG : BROWSER_OUTPUT: Values: 58.0 58.0 59.0 59.0 58.0 58.0 57.0 65.0 55.0 55.0 13:09:15 INFO - 2015-11-18 13:09:15,663 DEBUG : BROWSER_OUTPUT: 13:09:15 INFO - 2015-11-18 13:09:15,663 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 13:09:15 INFO - 2015-11-18 13:09:15,663 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 69.0 69.0 70.0 69.0 70.0 70.0 69.0 13:09:15 INFO - 2015-11-18 13:09:15,663 DEBUG : BROWSER_OUTPUT: 13:09:15 INFO - 2015-11-18 13:09:15,663 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.00 stddev:0.92 (1.1%) stddev-sans-first:0.97 13:09:15 INFO - 2015-11-18 13:09:15,663 DEBUG : BROWSER_OUTPUT: Values: 85.0 85.0 87.0 84.0 85.0 85.0 84.0 84.0 85.0 84.0 13:09:15 INFO - 2015-11-18 13:09:15,663 DEBUG : BROWSER_OUTPUT: 13:09:15 INFO - 2015-11-18 13:09:15,663 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.50 Median:119.50 stddev:3.21 (2.7%) stddev-sans-first:2.71 13:09:15 INFO - 2015-11-18 13:09:15,664 DEBUG : BROWSER_OUTPUT: Values: 124.0 117.0 117.0 113.0 121.0 119.0 121.0 118.0 120.0 115.0 13:09:15 INFO - 2015-11-18 13:09:15,664 DEBUG : BROWSER_OUTPUT: 13:09:15 INFO - 2015-11-18 13:09:15,664 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.80 Median:150.00 stddev:4.83 (3.2%) stddev-sans-first:4.80 13:09:15 INFO - 2015-11-18 13:09:15,664 DEBUG : BROWSER_OUTPUT: Values: 142.0 141.0 150.0 151.0 150.0 140.0 151.0 150.0 151.0 142.0 13:09:15 INFO - 2015-11-18 13:09:15,664 DEBUG : BROWSER_OUTPUT: 13:09:15 INFO - 2015-11-18 13:09:15,664 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:68.50 stddev:2.75 (4.0%) stddev-sans-first:2.92 13:09:15 INFO - 2015-11-18 13:09:15,664 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 76.0 66.0 69.0 69.0 67.0 67.0 68.0 68.0 13:09:15 INFO - 2015-11-18 13:09:15,664 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:09:15 INFO - 2015-11-18 13:09:15,664 DEBUG : BROWSER_OUTPUT: 13:09:16 INFO - 2015-11-18 13:09:16,840 INFO : Browser exited with error code: 0 13:09:16 INFO - 2015-11-18 13:09:16,889 INFO : Completed test kraken (00:01:00) 13:09:16 INFO - 2015-11-18 13:09:16,889 INFO : Starting test v8_7 13:09:16 INFO - 2015-11-18 13:09:16,889 DEBUG : operating with platform_type : linux_ 13:09:16 INFO - 2015-11-18 13:09:16,889 INFO : Initialising browser for v8_7 test... 13:09:16 INFO - 2015-11-18 13:09:16,895 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWiqWg0/profile http://localhost:59629/getInfo.html 13:09:21 INFO - 2015-11-18 13:09:21,568 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:09:21 INFO - 2015-11-18 13:09:21,568 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:09:21 INFO - 2015-11-18 13:09:21,568 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:09:21 INFO - 2015-11-18 13:09:21,568 DEBUG : BROWSER_OUTPUT: __metrics 13:09:21 INFO - 2015-11-18 13:09:21,685 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:09:23 INFO - 2015-11-18 13:09:23,415 INFO : Browser initialized. 13:09:23 INFO - 2015-11-18 13:09:23,416 INFO : Running cycle 1/1 for v8_7 test... 13:09:23 INFO - 2015-11-18 13:09:23,416 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWiqWg0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:09:35 INFO - 2015-11-18 13:09:35,212 DEBUG : BROWSER_OUTPUT: RSS: Main: 140173312 13:09:35 INFO - 2015-11-18 13:09:35,212 DEBUG : BROWSER_OUTPUT: 13:09:56 INFO - 2015-11-18 13:09:56,604 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59629/tests/v8_7/run.html (next: http://localhost:59629/tests/v8_7/run.html) 13:09:56 INFO - 2015-11-18 13:09:56,854 DEBUG : BROWSER_OUTPUT: RSS: Main: 544653312 13:09:56 INFO - 2015-11-18 13:09:56,854 DEBUG : BROWSER_OUTPUT: 13:09:56 INFO - 2015-11-18 13:09:56,854 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:09:56 INFO - 2015-11-18 13:09:56,855 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:09:56 INFO - 2015-11-18 13:09:56,855 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:09:56 INFO - 2015-11-18 13:09:56,855 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:09:56 INFO - 2015-11-18 13:09:56,855 DEBUG : BROWSER_OUTPUT: |0;Richards;163.45210853220007 13:09:56 INFO - 2015-11-18 13:09:56,855 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;187.93459875963165 13:09:56 INFO - 2015-11-18 13:09:56,855 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.7695125387433 13:09:56 INFO - 2015-11-18 13:09:56,855 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5030.150753768844 13:09:56 INFO - 2015-11-18 13:09:56,855 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1988.0715705765408 13:09:56 INFO - 2015-11-18 13:09:56,856 DEBUG : BROWSER_OUTPUT: |5;Earley;781.25 13:09:56 INFO - 2015-11-18 13:09:56,856 DEBUG : BROWSER_OUTPUT: |6;Boyer;12268.292682926829 13:09:56 INFO - 2015-11-18 13:09:56,856 DEBUG : BROWSER_OUTPUT: |7;RegExp;25948.71794871795 13:09:56 INFO - 2015-11-18 13:09:56,856 DEBUG : BROWSER_OUTPUT: |8;Splay;646.8305304010349 13:09:56 INFO - 2015-11-18 13:09:56,856 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 13:09:56 INFO - 2015-11-18 13:09:56,857 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:09:56 INFO - 2015-11-18 13:09:56,857 DEBUG : BROWSER_OUTPUT: __startTimestamp1447880996853__endTimestamp 13:09:56 INFO - 2015-11-18 13:09:56,857 DEBUG : BROWSER_OUTPUT: 13:09:56 INFO - 2015-11-18 13:09:56,857 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:09:56 INFO - 2015-11-18 13:09:56,858 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:09:56 INFO - 2015-11-18 13:09:56,858 DEBUG : BROWSER_OUTPUT: 13:09:56 INFO - 2015-11-18 13:09:56,858 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.45 Median:163.45 stddev:0.00 (0.0%) 13:09:56 INFO - 2015-11-18 13:09:56,858 DEBUG : BROWSER_OUTPUT: Values: 163.5 13:09:56 INFO - 2015-11-18 13:09:56,858 DEBUG : BROWSER_OUTPUT: 13:09:56 INFO - 2015-11-18 13:09:56,859 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:187.93 Median:187.93 stddev:0.00 (0.0%) 13:09:56 INFO - 2015-11-18 13:09:56,859 DEBUG : BROWSER_OUTPUT: Values: 187.9 13:09:56 INFO - 2015-11-18 13:09:56,859 DEBUG : BROWSER_OUTPUT: 13:09:56 INFO - 2015-11-18 13:09:56,859 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.77 Median:281.77 stddev:0.00 (0.0%) 13:09:56 INFO - 2015-11-18 13:09:56,860 DEBUG : BROWSER_OUTPUT: Values: 281.8 13:09:56 INFO - 2015-11-18 13:09:56,860 DEBUG : BROWSER_OUTPUT: 13:09:56 INFO - 2015-11-18 13:09:56,860 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5030.15 Median:5030.15 stddev:0.00 (0.0%) 13:09:56 INFO - 2015-11-18 13:09:56,860 DEBUG : BROWSER_OUTPUT: Values: 5030.2 13:09:56 INFO - 2015-11-18 13:09:56,860 DEBUG : BROWSER_OUTPUT: 13:09:56 INFO - 2015-11-18 13:09:56,861 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1988.07 Median:1988.07 stddev:0.00 (0.0%) 13:09:56 INFO - 2015-11-18 13:09:56,861 DEBUG : BROWSER_OUTPUT: Values: 1988.1 13:09:56 INFO - 2015-11-18 13:09:56,861 DEBUG : BROWSER_OUTPUT: 13:09:56 INFO - 2015-11-18 13:09:56,861 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:781.25 Median:781.25 stddev:0.00 (0.0%) 13:09:56 INFO - 2015-11-18 13:09:56,861 DEBUG : BROWSER_OUTPUT: Values: 781.3 13:09:56 INFO - 2015-11-18 13:09:56,861 DEBUG : BROWSER_OUTPUT: 13:09:56 INFO - 2015-11-18 13:09:56,862 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 13:09:56 INFO - 2015-11-18 13:09:56,862 DEBUG : BROWSER_OUTPUT: Values: 12268.3 13:09:56 INFO - 2015-11-18 13:09:56,862 DEBUG : BROWSER_OUTPUT: 13:09:56 INFO - 2015-11-18 13:09:56,862 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25948.72 Median:25948.72 stddev:0.00 (0.0%) 13:09:56 INFO - 2015-11-18 13:09:56,862 DEBUG : BROWSER_OUTPUT: Values: 25948.7 13:09:56 INFO - 2015-11-18 13:09:56,862 DEBUG : BROWSER_OUTPUT: 13:09:56 INFO - 2015-11-18 13:09:56,863 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:646.83 Median:646.83 stddev:0.00 (0.0%) 13:09:56 INFO - 2015-11-18 13:09:56,863 DEBUG : BROWSER_OUTPUT: Values: 646.8 13:09:56 INFO - 2015-11-18 13:09:56,863 DEBUG : BROWSER_OUTPUT: 13:09:56 INFO - 2015-11-18 13:09:56,863 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 13:09:56 INFO - 2015-11-18 13:09:56,864 DEBUG : BROWSER_OUTPUT: Values: 4854.4 13:09:56 INFO - 2015-11-18 13:09:56,865 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:09:56 INFO - 2015-11-18 13:09:56,865 DEBUG : BROWSER_OUTPUT: 13:09:57 INFO - 2015-11-18 13:09:57,788 INFO : Browser exited with error code: 0 13:09:57 INFO - 2015-11-18 13:09:57,805 INFO : Completed test v8_7 (00:00:40) 13:09:57 INFO - 2015-11-18 13:09:57,866 INFO : Completed test suite (00:20:19) 13:09:57 INFO - 2015-11-18 13:09:57,867 DEBUG : Working with test: dromaeo_css 13:09:57 INFO - 2015-11-18 13:09:57,867 DEBUG : Generating results file: dromaeo_css 13:09:57 INFO - 2015-11-18 13:09:57,868 DEBUG : Working with test: kraken 13:09:57 INFO - 2015-11-18 13:09:57,868 DEBUG : Generating results file: kraken 13:09:57 INFO - 2015-11-18 13:09:57,868 INFO : javascript benchmark 13:09:57 INFO - 2015-11-18 13:09:57,868 DEBUG : Working with test: v8_7 13:09:57 INFO - 2015-11-18 13:09:57,868 DEBUG : Generating results file: v8_7 13:09:57 INFO - 2015-11-18 13:09:57,869 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:09:57 INFO - 2015-11-18 13:09:57,919 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 13:09:57 INFO - 2015-11-18 13:09:57,919 DEBUG : process_Request line: dromaeo_css 6763.64 graph.html#tests=[[72,64,35]] 13:09:57 INFO - 2015-11-18 13:09:57,919 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:09:57 INFO - 2015-11-18 13:09:57,948 DEBUG : process_Request line: kraken 1495.30 graph.html#tests=[[232,64,35]] 13:09:57 INFO - 2015-11-18 13:09:57,948 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:09:57 INFO - 2015-11-18 13:09:57,976 DEBUG : process_Request line: v8_7 19787.77 graph.html#tests=[[230,64,35]] 13:09:57 INFO - 2015-11-18 13:09:57,977 INFO : javascript benchmark 13:09:58 INFO - 2015-11-18 13:09:57,981 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3137.2313783123136, 3215.4212241796467, 3252.414565378231, 3254.0, 3274.001429563982, 5105.897882042357, 5181.911798522315, 5296.470352964707, 5297.152455607104, 5317.0, 5211.400688920775, 5284.445133261001, 5328.706921119337, 5358.785648574052, 5384.0847056000475, 4906.190478571031, 4960.751962401883, 4982.427020892589, 4989.600831933455, 5018.5232402921665, 5015.724135172564, 5038.0, 5088.720120393377, 5103.132467480537, 5107.259447380127, 4780.545848144421, 4842.322074909515, 4895.534924182197, 4926.827561035347, 4930.260460930853, 4899.951000489985, 4906.239532872411, 4909.533594308535, 4912.828051018233, 4933.284673722326, 4877.146499362633, 4889.657723959324, 4893.804247830082, 4904.803807847682, 4944.8269310574315, 5017.147084995523, 5120.1039818031695, 5126.102931986925, 5141.203113517374, 5151.896962060775, 5700.37295897451, 5715.2855893013375, 5716.1711551825165, 5767.452092051249, 5814.447627475383, 5764.423557644244, 5787.652740835521, 5803.21656576361, 5804.680742559158, 5808.273965754281, 5229.47705229474, 5410.702411367373, 5414.0, 5414.7834086636485, 5417.972910135463, 5683.914741278884, 5729.455701708331, 5730.885382292331, 5765.85585360361, 5781.71091445426, 5611.354694210137, 5612.663240205601, 5660.943390566124, 5665.830025099253, 5671.716414179275, 5587.944120558824, 5671.631343962629, 5677.772889084473, 5688.431156884279, 5706.144078388192, 5597.692126933058, 5634.661920284796, 5658.066419040812, 5680.11958146488, 5712.028955077647, 5667.858303542362, 5710.057840456361, 5710.428957104256, 5719.113537401709, 5720.885582288331, 4308.0, 4319.827206911751, 4422.49141348749, 4444.82220711168, 4477.059817438309, 3936.9803150984635, 3952.3478626026385, 3956.9010774730864, 3982.7212095153063, 3991.1419044904906, 5461.2354270402175, 5462.180672899097, 5471.863203419866, 5477.507024367746, 5501.229827824108, 5504.339479262434, 5612.214289999403, 5772.538196944319, 5811.15738217956, 5918.822435326947, 5408.864778380572, 5421.539169170585, 5427.48438898304, 5428.75570599324, 5480.588955828329, 5000.449950505442, 5011.423686276052, 5052.090623687698, 5052.418971818214, 5112.642115051911, 5682.204491371212, 5822.388649191858, 5823.0, 5928.9110663339225, 5946.286445626466, 5738.770449181986, 5739.655620662774, 5750.568707346882, 5752.763155921497, 5756.453136951983, 5781.537477001913, 5858.150568167677, 5864.179014937998, 5865.266841644794, 5867.882642347215, 5612.01789686795, 5635.8591035224445, 5703.372629010722, 5709.25779648643, 5747.540196784331, 5784.50831679312, 5792.7103644818435, 5793.304803423616, 5836.795712150054, 5844.824655260179, 5417.052015897281, 5534.225208470898, 5632.85917852057, 5639.182318563703, 5640.492355687844, 5404.486573775485, 5451.318585176853, 5451.427600102091, 5462.481064298885, 5499.0, 5489.094299440707, 5491.505764481056, 5492.340919089735, 5492.945070549403, 5517.062099443185, 5400.9459905400445, 5440.727963601883, 5514.420985796433, 5603.327600687943, 5643.746031428514, 5405.8107966221, 5426.294581704353, 5474.151506516497, 5578.693171875586, 5606.355269144101], "unit": "ms", "name": "dojo.html", "value": 5281.192930640632}, {"lowerIsBetter": false, "replicates": [545.2294828507987, 584.7660935625751, 590.9793157239492, 595.0716881664604, 613.0742578706155, 31104.68895311049, 39743.20513589727, 40556.188876222455, 40602.0, 40608.59391406085, 42575.0, 43058.56941430585, 43110.353344699855, 43122.35316470255, 43143.568564314344, 7633.274838890325, 7778.0, 7787.922120778805, 8784.956075219616, 8966.596503157341, 10742.409167495785, 11004.614838480655, 11007.61473348433, 11021.944890275538, 11028.338299702003, 10503.264771466, 10531.789364212711, 10624.840627390595, 10625.20310976676, 10629.681109566725, 7662.540247585135, 7742.690292388298, 10535.47322633869, 10762.246642735012, 11049.944750276198, 10377.584896604127, 10515.94742026285, 10536.420496872668, 10536.420496872668, 10537.525811338508, 38841.805790970866, 39080.0, 39225.41161882574, 39265.803670981746, 39295.21409571821, 3213.271038267667, 3322.96677033229, 3386.4243078676436, 3402.2515046689687, 3453.620101788801, 29334.559981600294, 29710.771692123177, 29877.0, 29986.0, 30706.078817635283, 3571.2500374921296, 3580.3197392495345, 3607.134287770942, 3667.1015601177614, 3760.417135344026, 251847.0, 252435.0, 252852.0, 252948.0, 253112.0, 56172.43827561754, 57274.42725572691, 57741.0, 64266.67866660637, 65379.67310163419, 59041.40958590359, 59106.40893591009, 59209.0, 59286.70356648189, 59299.407005930254, 15881.841181588035, 16142.19289035567, 16170.353185872433, 16178.19109044543, 16200.67598648044, 12183.329916854658, 12249.265044097383, 12278.079144064232, 12313.56902508408, 12351.814722779165, 19154.0, 19156.0, 19222.327218547285, 19344.129514171895, 19441.611167776566, 7531.548107113591, 7712.575808330484, 7731.149573547018, 7769.145394006655, 7821.452498325177, 915.4004127296631, 927.5408672706918, 939.1688355805026, 974.2400927276594, 1100.6973082402403, 25295.873520632278, 25352.366190845376, 25416.237512874643, 28842.567361489593, 29380.559291610214, 996.5615129343211, 1036.6268143468346, 1046.4558429616557, 1049.9317544359592, 1141.668916014363, 15017.624559386102, 15863.20683965797, 15967.44113956006, 16003.439879604159, 16370.181490925406, 320244.0, 323290.0, 324271.0, 324393.0, 324652.0, 51734.74132629313, 51842.74078629583, 51850.48149518456, 51858.22212666813, 51984.74007629938, 1371.1156304183746, 1372.7391795558813, 1374.615107769826, 1382.979255311171, 1388.7083712420506, 22215.0, 27982.3004424891, 29964.70035299619, 30543.54184687187, 30644.233894152825, 46573.767131164124, 46799.76600116977, 46915.0, 47016.29475557938, 47060.0, 273397.0, 275335.0, 275480.0, 275645.0, 275779.0, 31738.682613174497, 31884.681153188172, 32303.51544726878, 32562.837185813918, 32717.18207044843, 39428.0, 41106.0, 42144.36783448312, 42276.36585451282, 43361.56638433701, 35369.292614148086, 35865.46201806923, 35920.820395898896, 35979.82010089933, 36164.0, 30677.0, 34282.314353713286, 36122.0, 36370.27259454849, 36820.0, 33083.17292067718, 33208.833955830065, 33217.0, 33294.0, 33303.33393332071, 28851.0, 30242.395152096396, 31588.842055789573, 32744.836275818467, 32851.50722739209, 24785.10099633921, 24840.875795620905, 24853.234824281004, 25018.499630007664, 25121.49757004886], "unit": "ms", "name": "ext.html", "value": 18654.50634321457}, {"lowerIsBetter": false, "replicates": [354.30556110024366, 354.46298857231295, 359.1882345898269, 360.866479402621, 363.69449662283677, 13777.380017899193, 13957.79063314051, 16717.916410417947, 16740.246688899013, 17254.913725431372, 15183.468578599724, 15786.289616967235, 15795.289211985459, 16262.51212463628, 16328.591785205375, 5183.196604526304, 5313.362396512424, 5315.14957606783, 5316.680999140064, 5318.25544423781, 3971.0, 4102.753834769908, 5239.659422137568, 5297.073012222865, 5651.717414129298, 5709.086546152616, 5733.397993210715, 5777.855553611173, 5784.363719990798, 5792.768289268424, 5472.370677372093, 5708.71456427177, 5710.486056254957, 5717.599768016241, 5756.625819321752, 5024.9748751256375, 5031.949680503185, 5037.722925239111, 5039.899202015976, 5040.470750571174, 20600.175992960263, 20847.37457876266, 21063.262785802577, 21165.68251476214, 21266.893665531574, 2122.628540005493, 2140.529083601605, 2168.2086038595958, 2209.4807720185745, 2258.654272463249, 12764.17032892859, 13037.348132593332, 13105.410256538478, 13193.538226162038, 13329.005842113069, 1582.1326076935668, 1765.6645237404853, 1774.6273282610666, 1777.8844375115575, 1870.3734249026593, 56170.0, 56622.0, 57267.0, 57498.0, 57569.712151439395, 9265.861012084824, 9447.574859131355, 9706.174975127053, 9761.658341957997, 9818.459984700767, 12615.93692031534, 12621.495140194289, 12628.116031877864, 12631.936840315924, 12633.684157895943, 5517.2551705520045, 5595.860103497445, 5626.831195064155, 5784.681842498619, 7558.168601453835, 5492.752826122834, 5815.098659707752, 5918.141869428909, 5961.523078153824, 5962.701864906824, 3304.686054824788, 3334.449815780369, 3340.1315657929113, 3359.4792807114936, 3360.445526488102, 1125.8460078419685, 1159.6984783956232, 1163.8021536338842, 1208.6523526268322, 1218.0620921890095, 478.8826737449347, 488.7482946282667, 489.60831334932624, 500.7696459628539, 515.9742012899341, 11337.829932551018, 11981.64055078349, 12330.383480825923, 12366.876331236752, 12393.0, 511.08770844043204, 514.2466286889725, 520.3183829183781, 521.9712915789668, 551.2447946313576, 6407.615543067338, 6671.86656266872, 6686.0, 6703.592245628375, 6760.0, 551311.0, 553470.0, 557731.0, 557920.0, 560280.0, 68673.31326686768, 71067.0, 71948.0, 72623.27376726165, 72998.0, 548.2105767694508, 571.4799532425556, 571.5113577890844, 572.6449601247253, 572.9054705973467, 10770.838437423601, 10960.177986651193, 11176.764647070457, 11245.606403776155, 11255.606053788078, 33387.499187512694, 33526.32947340991, 33667.494987575694, 34781.47827782535, 34787.13032174216, 46370.7681461604, 46689.2996605058, 46783.0, 47819.52180478151, 48155.0, 6945.791626251221, 6992.741306564867, 7052.294770522906, 7070.469714771516, 7071.646417679199, 11885.16803823724, 12497.12520123619, 12542.12205145631, 12559.120861539604, 12561.62315130511, 8533.530655813742, 9247.861282080908, 9254.953725231331, 9536.713898583053, 10789.0, 10566.366018038942, 10586.4706764663, 10741.67774966721, 10750.51622676997, 10892.237543371888, 10839.512221949873, 10947.726306842393, 11213.327200368005, 11264.324140551593, 11265.887341126483, 6591.802245932629, 6691.029800678777, 6720.596764194164, 6968.581885086911, 7031.507794454339, 10888.510017049093, 10910.61812836547, 11195.2723073, 11201.551937922392, 11224.887751122711], "unit": "ms", "name": "jquery.html", "value": 7437.187766540975}, {"lowerIsBetter": false, "replicates": [1340.6447291467769, 1706.8634509239262, 1754.6490701859632, 1778.7065134252846, 1792.5877048278896, 6915.343042410976, 7177.85644287114, 7378.299061589147, 7485.401167906554, 7517.24827517248, 7576.128745194291, 7613.543187408759, 7620.580868052255, 7634.160242373348, 7638.732644357448, 1920.7407000055023, 1960.1963195090016, 2191.244020812817, 2197.1540956731615, 2209.2930262316067, 2167.4364665187086, 2223.5775202711516, 2224.710787597618, 2225.0, 2225.2656623314347, 2079.324219628619, 2120.8303335733103, 2122.352682431858, 2125.1393185759716, 2138.9893050534724, 1801.3695206677558, 1844.5204246895837, 1854.1192933356683, 1878.398912348056, 2159.6220661384273, 2166.2851259084464, 2171.359448962544, 2172.0660116150048, 2172.1637169689784, 2172.6197915364905, 7455.589942553157, 7590.278923502258, 7590.316871481593, 7609.315161635479, 7609.961950190269, 4672.789724462374, 4700.482946875841, 4737.952620473786, 4755.2153894607345, 4760.381150450419, 3188.601424821897, 3205.951910721341, 3241.9675803241903, 3252.983735081333, 3253.1704415374165, 1020.7090979070929, 1037.8495118207893, 1038.8234000219904, 1063.8616979792655, 1068.8076146293663, 10780.676579702622, 10796.028357447867, 10803.729906752316, 10816.891831081668, 10841.83737243942, 4306.095719898856, 4371.038371558252, 4418.955810441918, 4463.910721785611, 4467.508574056851, 9285.907140928639, 9286.860697089549, 9293.442393456415, 9300.255979521622, 9311.0, 4836.153673107192, 4856.854294371175, 4868.780904859219, 4869.9513004870205, 4870.6103511718975, 4393.626541743924, 4395.428594282723, 4397.362382454527, 4398.846040388571, 4399.076193999232, 3693.741438099361, 3737.9065523362133, 3745.3071181830906, 3765.4728338032696, 3784.280986612535, 1146.2606618730872, 1146.4497041420166, 1158.0793269350886, 1162.9825552616717, 1163.1741463560797, 1258.6035398849333, 1269.5746924780117, 1277.2974863824859, 1318.6241921052647, 1319.089828018664, 7338.926610733931, 7358.77923662291, 7402.666879990414, 7415.85168296631, 7464.738734144279, 478.6027597094403, 483.9806407743651, 486.9440014398389, 506.2558039681662, 506.3872714016008, 4914.950850491521, 6010.308814486302, 6081.483073938764, 6114.174586430775, 6115.113308570232, 9305.860412093823, 9371.625134994523, 9412.905870941204, 9416.05839416053, 9453.858192127123, 9120.315976301805, 9238.307126965505, 9267.21228695555, 9290.303227257848, 9330.766730831649, 7121.465890058163, 7197.388222001188, 7204.423646108299, 7227.530210536298, 7293.197748247689, 6938.826529336807, 7249.601271930094, 7276.126864776261, 7294.051773269441, 7301.817454563678, 7870.842583148419, 8085.353171746128, 8197.590120493833, 8323.458975166595, 8343.499390036617, 8179.304759095544, 8186.549739764132, 8201.343892488705, 8216.507009579444, 8273.586320683822, 6991.335823096798, 7094.077769889881, 7104.0, 7107.893381599177, 7110.928890711233, 7474.177840437439, 7578.621068946421, 7644.694212231449, 7653.043369578802, 7656.73201437947, 6998.16022077354, 7015.719371225298, 7129.82175445618, 7158.128196931005, 7297.781066568012, 6944.0, 7018.192907815666, 7032.894506582303, 7096.929030709627, 7137.10786151731, 7144.3570078693165, 7165.426765858823, 7177.995080688604, 7190.640467976685, 7208.783736487913, 6540.37866402691, 6545.541812073109, 6604.5046621502615, 6646.368594983469, 6650.301718319701, 6494.577852439576, 6540.542162048611, 6586.868262634624, 6590.1103351046995, 6604.0], "unit": "ms", "name": "mootools.html", "value": 4386.750608587359}, {"lowerIsBetter": false, "replicates": [342.9914252143696, 345.28870526714985, 348.99127521811954, 349.6555892445942, 353.7064236683553, 5945.286565612128, 6054.334023257438, 6058.515318774498, 6087.543434242428, 6095.0, 5719.714014299289, 5791.768329266834, 5873.941260587393, 5948.286205655317, 5959.225300710901, 4582.541745825424, 4605.815767369301, 4606.424196975369, 4624.05206932578, 4629.791659375336, 4412.933805992912, 4607.493175750665, 4620.075984803036, 4626.606738427237, 4631.907361852761, 4448.888777780549, 4454.37638730578, 4528.026474308023, 4541.636669066484, 4575.771211439432, 4519.909601807945, 4554.681172317939, 4565.954340456587, 4569.885752856172, 4572.657050721209, 4040.8383664653675, 4044.5955404459614, 4044.6562042226446, 4047.150098479323, 4047.3119569673227, 5525.640833345819, 5634.183043458716, 5644.887102257973, 5657.745401456903, 5658.264425624642, 5318.840434786963, 5357.8392648220615, 5367.758450869681, 5371.838844834661, 5378.677279363251, 6281.905771413432, 6282.560220784547, 6289.371062893674, 6291.496680265568, 6291.559590828644, 4498.910021799578, 4504.707194032378, 4505.43682039745, 4507.030988337523, 4519.028408892071, 6399.584027038274, 6543.836404089889, 6545.476361891085, 6550.7707230246715, 6588.604683718992, 4418.873187337208, 4461.174682683714, 4472.798724057425, 4474.463064432289, 4480.439945006874, 4527.501974782771, 4544.250198717241, 4546.408966834357, 4550.8850331668955, 4551.226291530448, 5255.290535777697, 5258.447862974409, 5263.815766448156, 5265.0, 5268.789248430096, 6228.56400051992, 6382.680865956683, 6424.453921416732, 6425.550211485244, 6430.196225471816, 1581.841815818409, 1618.7248167811501, 1619.1175809184024, 1621.2704283072665, 1621.4000819696553, 1078.223678951154, 1078.9352638841538, 1084.5336505302637, 1099.6536091131268, 1104.3705088099707, 6176.598521096114, 6192.969035154795, 6195.690215489208, 6199.163112979781, 6203.720832562545, 6598.769043083469, 6600.471962243009, 6607.603543787388, 6608.570442921195, 6610.173728283965, 5968.850778730566, 6083.239595050619, 6141.96929015361, 6211.09939058834, 6252.531060170505, 3557.1640664443835, 3557.1996300832625, 3558.91102722434, 3566.768160069639, 3579.266250418658, 6803.285655006153, 6838.589684618939, 6845.657717114224, 6853.725850965906, 6869.828254293583, 6653.367930046637, 6757.155355580552, 6821.4542836572955, 6823.590584564942, 6825.55633883796, 6779.93220067793, 6790.0493930849725, 6790.660466976631, 6793.218779840283, 6793.93206067933, 6531.706073226621, 6630.204375474974, 6633.071370008106, 6636.568623039487, 6649.73401063952, 6547.508936829852, 6561.540692151503, 6566.0, 6566.9343306568235, 6568.244651865097, 6811.114555107804, 6824.385805277549, 6825.35159159879, 6827.829304267433, 6841.555298905555, 4504.887377815581, 4507.864764057083, 4509.909801804011, 4510.594046535827, 4515.503294637653, 6452.935470645421, 6627.304133065959, 6627.9337206627315, 6656.167979002625, 6661.666916654245, 6455.0962865199845, 6457.515686323639, 6460.644664543495, 6464.09502669636, 6475.255345635313, 6412.807615771534, 6439.034144878306, 6454.677266136769, 6460.967695161494, 6464.2889282177985, 6117.082437634391, 6275.6862156892885, 6306.590071645328, 6332.683365831782, 6339.080833279241, 6436.420722135031, 6450.516211284266, 6455.515836312389, 6461.967690161519, 6473.708683109366, 6183.166436809207, 6308.463780578702, 6318.589291696025, 6324.620522768649, 6324.873502529832], "unit": "ms", "name": "prototype.html", "value": 4817.42473804893}, {"lowerIsBetter": false, "replicates": [773.1147835728095, 823.2261674026411, 840.1304649687573, 842.5450256861295, 846.1327139681828, 13763.65590860229, 14078.507252246174, 14095.436182552685, 14138.787918181222, 14736.926315368408, 14162.78755818661, 14545.127292362438, 14547.199904005276, 14564.708705825877, 14571.708565828678, 671.07056726434, 684.6918886501095, 812.9796755081111, 819.2381085590414, 835.7826964989116, 822.284612387224, 825.0511911301991, 830.0122853803985, 830.0827585517976, 831.8170002599448, 867.7960679240374, 874.7419511244199, 874.9475031498099, 875.0068672057197, 875.6628697951303, 699.9475039372041, 701.3617607976743, 845.7716416567523, 859.7721603775004, 861.0700443520982, 625.368377938281, 628.7704987679509, 632.905064240363, 633.0946746152999, 633.1484153813115, 13146.60560183196, 13259.110829056792, 13278.336083195802, 13320.600381988555, 13362.933185334012, 10041.297109202358, 10511.264211505199, 10514.684559463229, 10658.0, 10935.070519005894, 9674.0, 9931.404115753077, 10073.143782778472, 10312.175025997902, 10374.429406382646, 3267.9346413071844, 3348.4809854472596, 3349.7152742016956, 3409.215880347509, 3435.519027336175, 46141.30788038182, 46223.07553848938, 46749.76625116887, 47155.764221179015, 47323.0, 7238.055468559709, 7375.262473752582, 7378.151512576015, 7381.11426628808, 7524.661390237453, 12460.937695311466, 12490.188137771016, 12495.187812792139, 12513.249205047545, 12518.624441266777, 6938.826529336807, 6950.270221626656, 6976.407005404496, 7046.048783414276, 7130.964345178345, 4187.24629566681, 4259.169461954951, 4319.67602429819, 4336.132773445323, 4350.956490435118, 2812.5078111330436, 2854.1437568729298, 2881.63122516807, 2889.508783506809, 2897.4350001749876, 453.2770231480783, 463.55730277584826, 464.25023586907577, 466.80160931603933, 467.31771613444073, 496.32747626965664, 648.9188851393576, 664.8005598320581, 667.033386359014, 680.9489288303298, 8592.44149130317, 8921.821563568692, 8950.23922966555, 8961.103889610988, 9141.268698504104, 570.3697414357158, 617.7343742190811, 655.2464665634558, 664.4750646988824, 682.1813823411926, 4115.650169735606, 4176.937345939813, 4206.558311377323, 4266.957330426656, 4321.805518751664, 56971.43028569744, 58040.70979645159, 62415.68792156101, 62725.0, 63057.36942630607, 50078.0, 50528.74735626298, 51336.74331628318, 51559.48440515547, 57212.0, 50071.0, 50319.49680503148, 50695.239571406455, 50781.23828142581, 52450.47549524456, 8548.572571371282, 8926.553672316228, 8931.910680893108, 8946.507942063248, 9037.322200834833, 35603.64396356003, 35864.28271434505, 36365.81817091003, 36401.0, 36893.81553092218, 45413.772931135136, 45646.54353456423, 46091.0, 46639.76680116577, 46773.0, 11267.830982535432, 11538.653840384803, 11792.941035294769, 12178.451969661564, 12196.146269761386, 12599.559015434415, 12876.420561074587, 12913.548025819051, 12947.189097103708, 13341.266230357423, 11110.555577776799, 11126.165537584551, 11552.191346605992, 11582.88417115818, 12219.144659873724, 11585.7103572408, 11800.822987655363, 12020.158588898694, 12036.75926481483, 12455.750884982432, 11525.308481491138, 11809.763804724029, 11878.168528202943, 12003.279803211835, 12302.446389912655, 9072.682456114004, 9199.678011269574, 9356.906430935604, 9394.483303418378, 9595.328327017041, 8776.254018408506, 8968.68609598661, 9393.214246706051, 9636.662716805158, 9860.408375497493], "unit": "ms", "name": "yui.html", "value": 6182.4922001052855}], "name": "dromaeo_css", "value": 6763.6429451373215}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 104.0, 110.0, 109.0, 110.0, 119.0, 112.0, 110.0, 111.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [146.0, 123.0, 155.0, 162.0, 125.0, 147.0, 150.0, 131.0, 160.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.2}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 164.0, 161.0, 160.0, 159.0, 159.0, 163.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 81.0, 95.0, 71.0, 71.0, 72.0, 110.0, 90.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 80.7}, {"lowerIsBetter": true, "replicates": [91.0, 91.0, 133.0, 89.0, 90.0, 90.0, 134.0, 90.0, 91.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 103.3}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 146.0, 145.0, 147.0, 145.0, 146.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 59.0, 59.0, 58.0, 58.0, 57.0, 65.0, 55.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 58.2}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 69.0, 69.0, 70.0, 69.0, 70.0, 70.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 87.0, 84.0, 85.0, 85.0, 84.0, 84.0, 85.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.8}, {"lowerIsBetter": true, "replicates": [124.0, 117.0, 117.0, 113.0, 121.0, 119.0, 121.0, 118.0, 120.0, 115.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.5}, {"lowerIsBetter": true, "replicates": [142.0, 141.0, 150.0, 151.0, 150.0, 140.0, 151.0, 150.0, 151.0, 142.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.8}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 76.0, 66.0, 69.0, 69.0, 67.0, 67.0, 68.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1495.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.45210853220007], "unit": "score", "name": "Richards", "value": 215.97763600000008}, {"lowerIsBetter": false, "replicates": [187.93459875963165], "unit": "score", "name": "DeltaBlue", "value": 351.8138780000001}, {"lowerIsBetter": false, "replicates": [281.7695125387433], "unit": "score", "name": "Encrypt", "value": 944.6763689999997}, {"lowerIsBetter": false, "replicates": [5030.150753768844], "unit": "score", "name": "Decrypt", "value": 52.91710189810189}, {"lowerIsBetter": false, "replicates": [1988.0715705765408], "unit": "score", "name": "RayTrace", "value": 372.21446699999984}, {"lowerIsBetter": false, "replicates": [781.25], "unit": "score", "name": "Earley", "value": 853.0726399999998}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [25948.71794871795], "unit": "score", "name": "RegExp", "value": 35.107129446640336}, {"lowerIsBetter": false, "replicates": [646.8305304010349], "unit": "score", "name": "Splay", "value": 125.98508600000002}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 19787.77442838285}]} 13:09:58 INFO - RETURN: dromaeo_css: 6763.64 13:09:58 INFO - RETURN: kraken: 1495.30 13:09:58 INFO - RETURN: v8_7: 19787.77 13:09:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19787.77"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1495.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6763.64"}}} 13:09:58 INFO - Return code: 0 13:09:58 INFO - # TBPL SUCCESS # 13:09:58 INFO - Running post-action listener: _resource_record_post_action 13:09:58 INFO - Running post-run listener: _resource_record_post_run 13:09:59 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 0; Write bytes: 510017536; Read time: 0; Write time: 1327180 13:09:59 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 99651584; Read time: 0; Write time: 191548 13:09:59 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 0; Write bytes: 364130304; Read time: 0; Write time: 957468 13:09:59 INFO - Running post-run listener: _upload_blobber_files 13:09:59 INFO - Blob upload gear active. 13:09:59 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:09:59 INFO - Copying logs to upload dir... 13:09:59 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1280.048474 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-11-18 13:09:58.861665) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 13:09:58.865164) ========= 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=ccb4611811c763f2fad71465000001de-1447879702.74719-157360663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009942 build_url: 'https://queue.taskcluster.net/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 13:09:58.915390) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 13:09:58.915678) ========= 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=ccb4611811c763f2fad71465000001de-1447879702.74719-157360663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004561 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 13:09:58.964430) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 13:09:58.964727) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 13:09:58.965055) ========= ========= Total master_lag: 0.24 =========