builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-004 starttime: 1447740058.19 results: success (0) buildid: 20151116203312 builduid: 3e17d0660b86454890afa588d6fea284 revision: ffdc7f22130425020f5d648ef99c10b947541659 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:58.187910) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:58.188376) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:58.188689) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1447738109.840296-1726088214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006717 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:58.212227) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:58.212591) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:58.228740) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:58.229083) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1447738109.840296-1726088214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004574 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:58.279172) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:58.279499) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:58.279918) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:58.280299) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1447738109.840296-1726088214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-16 22:00:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.5M=0s 2015-11-16 22:00:59 (47.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.188801 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:58.483560) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:58.483915) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1447738109.840296-1726088214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017390 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:58.534926) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:58.535282) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ffdc7f22130425020f5d648ef99c10b947541659 --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 ffdc7f22130425020f5d648ef99c10b947541659 --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=8e92d6ac3b8b0dffa3775d33000001f9-1447738109.840296-1726088214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-16 22:00:59,126 truncating revision to first 12 chars 2015-11-16 22:00:59,126 Setting DEBUG logging. 2015-11-16 22:00:59,126 attempt 1/10 2015-11-16 22:00:59,126 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ffdc7f221304?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 22:00:59,397 unpacking tar archive at: fx-team-ffdc7f221304/testing/mozharness/ program finished with exit code 0 elapsedTime=0.552062 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:59.101467) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:59.101817) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:59.111622) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:59.111957) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 22:00:59.112428) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-11-16 22:00:59.112754) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=8e92d6ac3b8b0dffa3775d33000001f9-1447738109.840296-1726088214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:00:59 INFO - MultiFileLogger online at 20151116 22:00:59 in /builds/slave/test-pgo 22:00:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 22:00:59 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:00:59 INFO - {'append_to_log': False, 22:00:59 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:00:59 INFO - 'blob_upload_branch': 'Fx-Team', 22:00:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:00:59 INFO - 'branch': 'Fx-Team', 22:00:59 INFO - 'buildbot_json_path': 'buildprops.json', 22:00:59 INFO - 'config_files': ('talos/linux_config.py',), 22:00:59 INFO - 'default_actions': ('clobber', 22:00:59 INFO - 'read-buildbot-config', 22:00:59 INFO - 'download-and-extract', 22:00:59 INFO - 'populate-webroot', 22:00:59 INFO - 'create-virtualenv', 22:00:59 INFO - 'install', 22:00:59 INFO - 'run-tests'), 22:00:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:00:59 INFO - 'download_minidump_stackwalk': True, 22:00:59 INFO - 'download_symbols': 'ondemand', 22:00:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:00:59 INFO - 'tooltool.py': '/tools/tooltool.py', 22:00:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:00:59 INFO - '/tools/misc-python/virtualenv.py')}, 22:00:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:00:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:00:59 INFO - 'installer_path': 'installer.exe', 22:00:59 INFO - 'log_level': 'info', 22:00:59 INFO - 'log_name': 'talos', 22:00:59 INFO - 'log_to_console': True, 22:00:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:00:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:00:59 INFO - 'opt_config_files': (), 22:00:59 INFO - 'pip_index': False, 22:00:59 INFO - 'sps_profile': False, 22:00:59 INFO - 'sps_profile_interval': 0, 22:00:59 INFO - 'suite': 'dromaeojs-e10s', 22:00:59 INFO - 'system_bits': '64', 22:00:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:00:59 INFO - 'title': 'talos-linux64-ix-004', 22:00:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:00:59 INFO - 'use_talos_json': True, 22:00:59 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:00:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:00:59 INFO - 'work_dir': 'build'} 22:00:59 INFO - ##### 22:00:59 INFO - ##### Running clobber step. 22:00:59 INFO - ##### 22:00:59 INFO - Running pre-action listener: _resource_record_pre_action 22:00:59 INFO - Running main action method: clobber 22:00:59 INFO - rmtree: /builds/slave/test-pgo/build 22:00:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:01:00 INFO - Running post-action listener: _resource_record_post_action 22:01:00 INFO - ##### 22:01:00 INFO - ##### Running read-buildbot-config step. 22:01:00 INFO - ##### 22:01:00 INFO - Running pre-action listener: _resource_record_pre_action 22:01:00 INFO - Running main action method: read_buildbot_config 22:01:00 INFO - Using buildbot properties: 22:01:00 INFO - { 22:01:00 INFO - "properties": { 22:01:00 INFO - "buildnumber": 57, 22:01:00 INFO - "product": "firefox", 22:01:00 INFO - "script_repo_revision": "production", 22:01:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:01:00 INFO - "repository": "", 22:01:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 22:01:00 INFO - "buildid": "20151116203312", 22:01:00 INFO - "slavename": "talos-linux64-ix-004", 22:01:00 INFO - "pgo_build": "True", 22:01:00 INFO - "basedir": "/builds/slave/test-pgo", 22:01:00 INFO - "project": "", 22:01:00 INFO - "platform": "ubuntu64_hw", 22:01:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:01:00 INFO - "slavebuilddir": "test", 22:01:00 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:01:00 INFO - "branch": "fx-team", 22:01:00 INFO - "repo_path": "integration/fx-team", 22:01:00 INFO - "stage_platform": "linux64-pgo", 22:01:00 INFO - "builduid": "3e17d0660b86454890afa588d6fea284", 22:01:00 INFO - "revision": "ffdc7f22130425020f5d648ef99c10b947541659" 22:01:00 INFO - }, 22:01:00 INFO - "sourcestamp": { 22:01:00 INFO - "repository": "", 22:01:00 INFO - "hasPatch": false, 22:01:00 INFO - "project": "", 22:01:00 INFO - "branch": "fx-team-linux64-pgo-talos", 22:01:00 INFO - "changes": [ 22:01:00 INFO - { 22:01:00 INFO - "category": null, 22:01:00 INFO - "files": [ 22:01:00 INFO - { 22:01:00 INFO - "url": null, 22:01:00 INFO - "name": "https://queue.taskcluster.net/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 22:01:00 INFO - } 22:01:00 INFO - ], 22:01:00 INFO - "repository": "", 22:01:00 INFO - "rev": "ffdc7f22130425020f5d648ef99c10b947541659", 22:01:00 INFO - "who": "sendchange", 22:01:00 INFO - "when": 1447739973, 22:01:00 INFO - "number": 6670193, 22:01:00 INFO - "comments": "", 22:01:00 INFO - "project": "", 22:01:00 INFO - "at": "Mon 16 Nov 2015 21:59:33", 22:01:00 INFO - "branch": "fx-team-linux64-pgo-talos", 22:01:00 INFO - "revlink": "", 22:01:00 INFO - "properties": [ 22:01:00 INFO - [ 22:01:00 INFO - "buildid", 22:01:00 INFO - "20151116203312", 22:01:00 INFO - "Change" 22:01:00 INFO - ], 22:01:00 INFO - [ 22:01:00 INFO - "builduid", 22:01:00 INFO - "3e17d0660b86454890afa588d6fea284", 22:01:00 INFO - "Change" 22:01:00 INFO - ], 22:01:00 INFO - [ 22:01:00 INFO - "pgo_build", 22:01:00 INFO - "True", 22:01:00 INFO - "Change" 22:01:00 INFO - ] 22:01:00 INFO - ], 22:01:00 INFO - "revision": "ffdc7f22130425020f5d648ef99c10b947541659" 22:01:00 INFO - } 22:01:00 INFO - ], 22:01:00 INFO - "revision": "ffdc7f22130425020f5d648ef99c10b947541659" 22:01:00 INFO - } 22:01:00 INFO - } 22:01:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 22:01:00 INFO - Running post-action listener: _resource_record_post_action 22:01:00 INFO - ##### 22:01:00 INFO - ##### Running download-and-extract step. 22:01:00 INFO - ##### 22:01:00 INFO - Running pre-action listener: _resource_record_pre_action 22:01:00 INFO - Running main action method: download_and_extract 22:01:00 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:00 INFO - https://queue.taskcluster.net/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:01:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/test_packages.json 22:01:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/test_packages.json 22:01:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:01:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:01:05 INFO - Downloaded 1302 bytes. 22:01:05 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:01:05 INFO - Using the following test package requirements: 22:01:05 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:01:05 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:05 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:01:05 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:05 INFO - u'jsshell-linux-x86_64.zip'], 22:01:05 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:05 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:01:05 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:01:05 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:05 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:01:05 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:05 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:01:05 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:05 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:01:05 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:01:05 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:05 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:01:05 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:01:05 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')]} 22:01:05 INFO - https://queue.taskcluster.net/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:01:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:01:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:01:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/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 22:01:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/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 22:01:16 INFO - Downloaded 22458461 bytes. 22:01:16 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 22:01:16 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:01:16 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 22:01:17 INFO - Return code: 0 22:01:17 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 22:01:17 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')]} 22:01:17 INFO - https://queue.taskcluster.net/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:01:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:01:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:01:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/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 22:01:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/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 22:01:20 INFO - Downloaded 22458461 bytes. 22:01:20 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 22:01:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:01:20 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 22:01:22 INFO - Return code: 0 22:01: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')]} 22:01:22 INFO - https://queue.taskcluster.net/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:01:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:01:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:01:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/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 22:01:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/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 22:01:22 INFO - Downloaded 11131693 bytes. 22:01:22 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 22:01:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:01:22 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 22:01:23 INFO - Return code: 0 22:01:23 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')]} 22:01:23 INFO - https://queue.taskcluster.net/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:01:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:01:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:01:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/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 22:01:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hs4ftGDtSDaQcTG9BKo7kw/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 22:01:24 INFO - Downloaded 57165258 bytes. 22:01:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:01:24 INFO - mkdir: /builds/slave/test-pgo/properties 22:01:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:01:24 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:01:24 INFO - Contents: 22:01:24 INFO - build_url:https://queue.taskcluster.net/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:01:24 INFO - Running post-action listener: _resource_record_post_action 22:01:24 INFO - Running post-action listener: set_extra_try_arguments 22:01:24 INFO - ##### 22:01:24 INFO - ##### Running populate-webroot step. 22:01:24 INFO - ##### 22:01:24 INFO - Running pre-action listener: _resource_record_pre_action 22:01:24 INFO - Running main action method: populate_webroot 22:01:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:01:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:01:24 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 22:01:24 INFO - '../fennec_ids.txt'], 22:01:24 INFO - 'tests': ['tcheck2']}, 22:01:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:01:24 INFO - '--tppagecycles', 22:01:24 INFO - '7'], 22:01:24 INFO - 'tests': ['tsvgm']}}, 22:01:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:01:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:01:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:01:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:01:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:01:24 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:01:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:01:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:24 INFO - 'talos_options': ['--e10s'], 22:01:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:01:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:24 INFO - 'tests': ['damp', 'tps']}, 22:01:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:24 INFO - 'talos_options': ['--e10s'], 22:01:24 INFO - 'tests': ['damp', 'tps']}, 22:01:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:01:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:01:24 INFO - 'other': {'tests': ['a11yr', 22:01:24 INFO - 'ts_paint', 22:01:24 INFO - 'tpaint', 22:01:24 INFO - 'sessionrestore', 22:01:24 INFO - 'sessionrestore_no_auto_restore']}, 22:01:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:01:24 INFO - 'tests': ['a11yr', 22:01:24 INFO - 'ts_paint', 22:01:24 INFO - 'tpaint', 22:01:24 INFO - 'sessionrestore', 22:01:24 INFO - 'sessionrestore_no_auto_restore']}, 22:01:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:01:24 INFO - 'tests': ['a11yr', 22:01:24 INFO - 'ts_paint', 22:01:24 INFO - 'tpaint', 22:01:24 INFO - 'sessionrestore', 22:01:24 INFO - 'sessionrestore_no_auto_restore']}, 22:01:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:01:24 INFO - 'tests': ['a11yr', 22:01:24 INFO - 'ts_paint', 22:01:24 INFO - 'tpaint', 22:01:24 INFO - 'sessionrestore', 22:01:24 INFO - 'sessionrestore_no_auto_restore']}, 22:01:24 INFO - 'other_l64': {'tests': ['a11yr', 22:01:24 INFO - 'ts_paint', 22:01:24 INFO - 'tpaint', 22:01:24 INFO - 'sessionrestore', 22:01:24 INFO - 'sessionrestore_no_auto_restore']}, 22:01:24 INFO - 'other_nol64': {'tests': ['a11yr', 22:01:24 INFO - 'ts_paint', 22:01:24 INFO - 'tpaint', 22:01:24 INFO - 'sessionrestore', 22:01:24 INFO - 'sessionrestore_no_auto_restore']}, 22:01:24 INFO - 'svgr': {'tests': ['tsvgx', 22:01:24 INFO - 'tsvgr_opacity', 22:01:24 INFO - 'tart', 22:01:24 INFO - 'tscrollx', 22:01:24 INFO - 'cart']}, 22:01:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:01:24 INFO - 'tests': ['tsvgx', 22:01:24 INFO - 'tsvgr_opacity', 22:01:24 INFO - 'tart', 22:01:24 INFO - 'tscrollx', 22:01:24 INFO - 'cart']}, 22:01:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:24 INFO - 'tests': ['tp5o']}, 22:01:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:24 INFO - 'talos_options': ['--e10s'], 22:01:24 INFO - 'tests': ['tp5o']}, 22:01:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:24 INFO - 'talos_options': ['--xperf_path', 22:01:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:01:24 INFO - 'tests': ['tp5n']}, 22:01:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:24 INFO - 'talos_options': ['--e10s', 22:01:24 INFO - '--xperf_path', 22:01:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:01:24 INFO - 'tests': ['tp5n']}}, 22:01:24 INFO - 'talos.zip': {'path': '', 22:01:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:01:24 INFO - Running post-action listener: _resource_record_post_action 22:01:24 INFO - ##### 22:01:24 INFO - ##### Running create-virtualenv step. 22:01:24 INFO - ##### 22:01:24 INFO - Running pre-action listener: _resource_record_pre_action 22:01:24 INFO - Running main action method: create_virtualenv 22:01:24 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:01:24 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 22:01:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:01:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:01:24 INFO - Using real prefix '/usr' 22:01:24 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:01:25 INFO - Installing distribute.............................................................................................................................................................................................done. 22:01:27 INFO - Installing pip.................done. 22:01:27 INFO - Return code: 0 22:01:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:27 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 0x7fe22aea4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24656c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25263d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25af8c0>, '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 0x255c420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255c8b0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1447738109.840296-1726088214', '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 22:01:27 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 22:01:27 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 22:01:27 INFO - Using env: {'DISPLAY': ':0', 22:01:27 INFO - 'HOME': '/home/cltbld', 22:01:27 INFO - 'LANG': 'en_US.UTF-8', 22:01:27 INFO - 'LANGUAGE': 'en_US:en', 22:01:27 INFO - 'LOGNAME': 'cltbld', 22:01:27 INFO - 'MAIL': '/var/mail/cltbld', 22:01:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:27 INFO - 'MOZ_NO_REMOTE': '1', 22:01:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:27 INFO - 'NO_EM_RESTART': '1', 22:01:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:27 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:27 INFO - 'SHELL': '/bin/bash', 22:01:27 INFO - 'SHLVL': '1', 22:01:27 INFO - 'TERM': 'linux', 22:01:27 INFO - 'TMOUT': '86400', 22:01:27 INFO - 'USER': 'cltbld', 22:01:27 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1447738109.840296-1726088214', 22:01:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:27 INFO - '_': '/tools/buildbot/bin/python'} 22:01:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:27 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 22:01:27 INFO - Cleaning up... 22:01:27 INFO - Return code: 0 22:01:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:27 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 0x7fe22aea4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24656c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25263d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25af8c0>, '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 0x255c420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255c8b0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1447738109.840296-1726088214', '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 22:01:27 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 22:01:27 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 22:01:27 INFO - Using env: {'DISPLAY': ':0', 22:01:27 INFO - 'HOME': '/home/cltbld', 22:01:27 INFO - 'LANG': 'en_US.UTF-8', 22:01:27 INFO - 'LANGUAGE': 'en_US:en', 22:01:27 INFO - 'LOGNAME': 'cltbld', 22:01:27 INFO - 'MAIL': '/var/mail/cltbld', 22:01:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:27 INFO - 'MOZ_NO_REMOTE': '1', 22:01:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:27 INFO - 'NO_EM_RESTART': '1', 22:01:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:27 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:27 INFO - 'SHELL': '/bin/bash', 22:01:27 INFO - 'SHLVL': '1', 22:01:27 INFO - 'TERM': 'linux', 22:01:27 INFO - 'TMOUT': '86400', 22:01:27 INFO - 'USER': 'cltbld', 22:01:27 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1447738109.840296-1726088214', 22:01:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:27 INFO - '_': '/tools/buildbot/bin/python'} 22:01:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:27 INFO - Downloading/unpacking psutil>=0.7.1 22:01:27 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 22:01:27 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 22:01:27 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 22:01:27 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 22:01:27 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 22:01:27 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 22:01:29 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:01:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:01:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:01:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:01:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:01:29 INFO - Installing collected packages: psutil 22:01:29 INFO - Running setup.py install for psutil 22:01:29 INFO - building 'psutil._psutil_linux' extension 22:01:29 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 22:01:29 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 22:01:29 INFO - building 'psutil._psutil_posix' extension 22:01:29 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 22:01:29 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 22:01:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:01:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:01:29 INFO - Successfully installed psutil 22:01:29 INFO - Cleaning up... 22:01:29 INFO - Return code: 0 22:01:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:29 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 0x7fe22aea4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24656c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25263d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25af8c0>, '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 0x255c420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255c8b0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1447738109.840296-1726088214', '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 22:01:29 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 22:01:29 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 22:01:29 INFO - Using env: {'DISPLAY': ':0', 22:01:29 INFO - 'HOME': '/home/cltbld', 22:01:29 INFO - 'LANG': 'en_US.UTF-8', 22:01:29 INFO - 'LANGUAGE': 'en_US:en', 22:01:29 INFO - 'LOGNAME': 'cltbld', 22:01:29 INFO - 'MAIL': '/var/mail/cltbld', 22:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:29 INFO - 'MOZ_NO_REMOTE': '1', 22:01:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:29 INFO - 'NO_EM_RESTART': '1', 22:01:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:29 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:29 INFO - 'SHELL': '/bin/bash', 22:01:29 INFO - 'SHLVL': '1', 22:01:29 INFO - 'TERM': 'linux', 22:01:29 INFO - 'TMOUT': '86400', 22:01:29 INFO - 'USER': 'cltbld', 22:01:29 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1447738109.840296-1726088214', 22:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:29 INFO - '_': '/tools/buildbot/bin/python'} 22:01:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:01:30 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 22:01:30 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 22:01:30 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 22:01:30 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 22:01:30 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 22:01:30 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 22:01:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:01:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:01:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:01:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:01:31 INFO - Installing collected packages: mozsystemmonitor 22:01:31 INFO - Running setup.py install for mozsystemmonitor 22:01:31 INFO - Successfully installed mozsystemmonitor 22:01:31 INFO - Cleaning up... 22:01:31 INFO - Return code: 0 22:01:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:01:31 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')]} 22:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:31 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')]} 22:01:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:31 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 0x7fe22aea4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24656c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25263d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25af8c0>, '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 0x255c420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255c8b0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1447738109.840296-1726088214', '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 22:01:31 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 22:01:31 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 22:01:31 INFO - Using env: {'DISPLAY': ':0', 22:01:31 INFO - 'HOME': '/home/cltbld', 22:01:31 INFO - 'LANG': 'en_US.UTF-8', 22:01:31 INFO - 'LANGUAGE': 'en_US:en', 22:01:31 INFO - 'LOGNAME': 'cltbld', 22:01:31 INFO - 'MAIL': '/var/mail/cltbld', 22:01:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:31 INFO - 'MOZ_NO_REMOTE': '1', 22:01:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:31 INFO - 'NO_EM_RESTART': '1', 22:01:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:31 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:31 INFO - 'SHELL': '/bin/bash', 22:01:31 INFO - 'SHLVL': '1', 22:01:31 INFO - 'TERM': 'linux', 22:01:31 INFO - 'TMOUT': '86400', 22:01:31 INFO - 'USER': 'cltbld', 22:01:31 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1447738109.840296-1726088214', 22:01:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:31 INFO - '_': '/tools/buildbot/bin/python'} 22:01:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:32 INFO - Downloading/unpacking blobuploader==1.2.4 22:01:32 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 22:01:32 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 22:01:32 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 22:01:32 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 22:01:32 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 22:01:32 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 22:01:33 INFO - Downloading blobuploader-1.2.4.tar.gz 22:01:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:01:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:01:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:01:33 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 22:01:33 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 22:01:33 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 22:01:33 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 22:01:33 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 22:01:33 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 22:01:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:01:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:01:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:01:34 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 22:01:34 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 22:01:34 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 22:01:34 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 22:01:34 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 22:01:34 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 22:01:34 INFO - Downloading docopt-0.6.1.tar.gz 22:01:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:01:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:01:34 INFO - Installing collected packages: blobuploader, requests, docopt 22:01:34 INFO - Running setup.py install for blobuploader 22:01:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:01:34 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:01:34 INFO - Running setup.py install for requests 22:01:34 INFO - Running setup.py install for docopt 22:01:34 INFO - Successfully installed blobuploader requests docopt 22:01:34 INFO - Cleaning up... 22:01:35 INFO - Return code: 0 22:01:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:01:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:35 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 0x7fe22aea4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24656c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25263d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25af8c0>, '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 0x255c420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255c8b0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1447738109.840296-1726088214', '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 22:01:35 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 22:01:35 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 22:01:35 INFO - Using env: {'DISPLAY': ':0', 22:01:35 INFO - 'HOME': '/home/cltbld', 22:01:35 INFO - 'LANG': 'en_US.UTF-8', 22:01:35 INFO - 'LANGUAGE': 'en_US:en', 22:01:35 INFO - 'LOGNAME': 'cltbld', 22:01:35 INFO - 'MAIL': '/var/mail/cltbld', 22:01:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:35 INFO - 'MOZ_NO_REMOTE': '1', 22:01:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:35 INFO - 'NO_EM_RESTART': '1', 22:01:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:35 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:35 INFO - 'SHELL': '/bin/bash', 22:01:35 INFO - 'SHLVL': '1', 22:01:35 INFO - 'TERM': 'linux', 22:01:35 INFO - 'TMOUT': '86400', 22:01:35 INFO - 'USER': 'cltbld', 22:01:35 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1447738109.840296-1726088214', 22:01:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:35 INFO - '_': '/tools/buildbot/bin/python'} 22:01:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:01:35 INFO - Running setup.py (path:/tmp/pip-106pFJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:01:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:01:35 INFO - Running setup.py (path:/tmp/pip-yAjef1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:01:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:01:35 INFO - Running setup.py (path:/tmp/pip-WhEKFp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:01:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:01:35 INFO - Running setup.py (path:/tmp/pip-angQKI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:01:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:01:35 INFO - Running setup.py (path:/tmp/pip-hlMhYD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:01:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:01:35 INFO - Running setup.py (path:/tmp/pip-lkTQvj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:01:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:01:35 INFO - Running setup.py (path:/tmp/pip-PQJKLN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:01:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:01:35 INFO - Running setup.py (path:/tmp/pip-BWr1En-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:01:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:01:35 INFO - Running setup.py (path:/tmp/pip-XghLn3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:01:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:01:35 INFO - Running setup.py (path:/tmp/pip-zB7ceL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:01:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:01:35 INFO - Running setup.py (path:/tmp/pip-2qYZdk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:01:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:01:36 INFO - Running setup.py (path:/tmp/pip-osto2K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:01:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:01:36 INFO - Running setup.py (path:/tmp/pip-WGO34Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:01:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:01:36 INFO - Running setup.py (path:/tmp/pip-OaQJUl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:01:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:01:36 INFO - Running setup.py (path:/tmp/pip-Nmz4ry-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:01:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:01:36 INFO - Running setup.py (path:/tmp/pip-J_FO0H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:01:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:01:36 INFO - Running setup.py (path:/tmp/pip-DkhpPZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:01:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:01:36 INFO - Running setup.py install for manifestparser 22:01:36 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:01:36 INFO - Running setup.py install for mozcrash 22:01:36 INFO - Running setup.py install for mozdebug 22:01:36 INFO - Running setup.py install for mozdevice 22:01:36 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:01:36 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:01:36 INFO - Running setup.py install for mozfile 22:01:36 INFO - Running setup.py install for mozhttpd 22:01:37 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:01:37 INFO - Running setup.py install for mozinfo 22:01:37 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:01:37 INFO - Running setup.py install for mozInstall 22:01:37 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:01:37 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:01:37 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:01:37 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:01:37 INFO - Running setup.py install for mozleak 22:01:37 INFO - Running setup.py install for mozlog 22:01:37 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:01:37 INFO - Running setup.py install for moznetwork 22:01:37 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:01:37 INFO - Running setup.py install for mozprocess 22:01:37 INFO - Running setup.py install for mozprofile 22:01:37 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:01:37 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:01:37 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:01:37 INFO - Running setup.py install for mozrunner 22:01:37 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:01:37 INFO - Running setup.py install for mozscreenshot 22:01:38 INFO - Running setup.py install for moztest 22:01:38 INFO - Running setup.py install for mozversion 22:01:38 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:01:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:01:38 INFO - Cleaning up... 22:01:38 INFO - Return code: 0 22:01:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:01:38 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')]} 22:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:38 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')]} 22:01:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:38 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 0x7fe22aea4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24656c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25263d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25af8c0>, '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 0x255c420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255c8b0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1447738109.840296-1726088214', '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 22:01:38 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 22:01:38 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 22:01:38 INFO - Using env: {'DISPLAY': ':0', 22:01:38 INFO - 'HOME': '/home/cltbld', 22:01:38 INFO - 'LANG': 'en_US.UTF-8', 22:01:38 INFO - 'LANGUAGE': 'en_US:en', 22:01:38 INFO - 'LOGNAME': 'cltbld', 22:01:38 INFO - 'MAIL': '/var/mail/cltbld', 22:01:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:38 INFO - 'MOZ_NO_REMOTE': '1', 22:01:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:38 INFO - 'NO_EM_RESTART': '1', 22:01:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:38 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:38 INFO - 'SHELL': '/bin/bash', 22:01:38 INFO - 'SHLVL': '1', 22:01:38 INFO - 'TERM': 'linux', 22:01:38 INFO - 'TMOUT': '86400', 22:01:38 INFO - 'USER': 'cltbld', 22:01:38 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1447738109.840296-1726088214', 22:01:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:38 INFO - '_': '/tools/buildbot/bin/python'} 22:01:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:01:38 INFO - Running setup.py (path:/tmp/pip-JXbgWn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:01:38 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)) 22:01:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:01:38 INFO - Running setup.py (path:/tmp/pip-bvyFQZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:01:38 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)) 22:01:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:01:38 INFO - Running setup.py (path:/tmp/pip-of1XA0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:01:38 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)) 22:01:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:01:38 INFO - Running setup.py (path:/tmp/pip-Ro5bwY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:01:38 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)) 22:01:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:01:38 INFO - Running setup.py (path:/tmp/pip-JK8MVk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:01:38 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)) 22:01:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:01:38 INFO - Running setup.py (path:/tmp/pip-hWYAzU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:01:38 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)) 22:01:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:01:38 INFO - Running setup.py (path:/tmp/pip-Bl04t7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:01:38 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)) 22:01:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:01:38 INFO - Running setup.py (path:/tmp/pip-04O3ra-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:01:39 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)) 22:01:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:01:39 INFO - Running setup.py (path:/tmp/pip-YCYXSg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:01:39 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)) 22:01:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:01:39 INFO - Running setup.py (path:/tmp/pip-kkNtof-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:01:39 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)) 22:01:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:01:39 INFO - Running setup.py (path:/tmp/pip-YuZc_o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:01:39 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)) 22:01:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:01:39 INFO - Running setup.py (path:/tmp/pip-xziXby-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:01:39 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)) 22:01:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:01:39 INFO - Running setup.py (path:/tmp/pip-LXdjAz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:01:39 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)) 22:01:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:01:39 INFO - Running setup.py (path:/tmp/pip-aZGTUR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:01:39 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)) 22:01:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:01:39 INFO - Running setup.py (path:/tmp/pip-BG7lmH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:01:39 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)) 22:01:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:01:39 INFO - Running setup.py (path:/tmp/pip-BmVAPf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:01:39 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)) 22:01:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:01:39 INFO - Running setup.py (path:/tmp/pip-Jhwfb7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:01:39 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)) 22:01:39 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)) 22:01:39 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)) 22:01:39 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)) 22:01:39 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)) 22:01:39 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)) 22:01:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:01:39 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 22:01:39 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 22:01:39 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 22:01:39 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 22:01:39 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 22:01:39 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 22:01:41 INFO - Downloading blessings-1.5.1.tar.gz 22:01:41 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 22:01:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:01:41 INFO - Installing collected packages: blessings 22:01:41 INFO - Running setup.py install for blessings 22:01:41 INFO - Successfully installed blessings 22:01:41 INFO - Cleaning up... 22:01:41 INFO - Return code: 0 22:01:41 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:01:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:01:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:01:42 INFO - Reading from file tmpfile_stdout 22:01:42 INFO - Current package versions: 22:01:42 INFO - argparse == 1.2.1 22:01:42 INFO - blessings == 1.5.1 22:01:42 INFO - blobuploader == 1.2.4 22:01:42 INFO - docopt == 0.6.1 22:01:42 INFO - manifestparser == 1.1 22:01:42 INFO - mozInstall == 1.12 22:01:42 INFO - mozcrash == 0.16 22:01:42 INFO - mozdebug == 0.1 22:01:42 INFO - mozdevice == 0.47 22:01:42 INFO - mozfile == 1.2 22:01:42 INFO - mozhttpd == 0.7 22:01:42 INFO - mozinfo == 0.9 22:01:42 INFO - mozleak == 0.1 22:01:42 INFO - mozlog == 3.0 22:01:42 INFO - moznetwork == 0.27 22:01:42 INFO - mozprocess == 0.22 22:01:42 INFO - mozprofile == 0.27 22:01:42 INFO - mozrunner == 6.11 22:01:42 INFO - mozscreenshot == 0.1 22:01:42 INFO - mozsystemmonitor == 0.0 22:01:42 INFO - moztest == 0.7 22:01:42 INFO - mozversion == 1.4 22:01:42 INFO - psutil == 3.1.1 22:01:42 INFO - requests == 1.2.3 22:01:42 INFO - wsgiref == 0.1.2 22:01:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:01:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fe22aea4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24656c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25263d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25af8c0>, '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 0x255c420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255c8b0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1447738109.840296-1726088214', '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 22:01:42 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 22:01:42 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 22:01:42 INFO - Using env: {'DISPLAY': ':0', 22:01:42 INFO - 'HOME': '/home/cltbld', 22:01:42 INFO - 'LANG': 'en_US.UTF-8', 22:01:42 INFO - 'LANGUAGE': 'en_US:en', 22:01:42 INFO - 'LOGNAME': 'cltbld', 22:01:42 INFO - 'MAIL': '/var/mail/cltbld', 22:01:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:42 INFO - 'MOZ_NO_REMOTE': '1', 22:01:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:42 INFO - 'NO_EM_RESTART': '1', 22:01:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:42 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:42 INFO - 'SHELL': '/bin/bash', 22:01:42 INFO - 'SHLVL': '1', 22:01:42 INFO - 'TERM': 'linux', 22:01:42 INFO - 'TMOUT': '86400', 22:01:42 INFO - 'USER': 'cltbld', 22:01:42 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1447738109.840296-1726088214', 22:01:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:42 INFO - '_': '/tools/buildbot/bin/python'} 22:01:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:42 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)) 22:01:42 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)) 22:01:42 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)) 22:01:42 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)) 22:01:42 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)) 22:01:42 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)) 22:01:42 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)) 22:01:42 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)) 22:01:42 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)) 22:01:42 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)) 22:01:42 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)) 22:01:42 INFO - Cleaning up... 22:01:42 INFO - Return code: 0 22:01:42 INFO - Running post-action listener: _resource_record_post_action 22:01:42 INFO - Running post-action listener: _start_resource_monitoring 22:01:42 INFO - Starting resource monitoring. 22:01:42 INFO - ##### 22:01:42 INFO - ##### Running install step. 22:01:42 INFO - ##### 22:01:42 INFO - Running pre-action listener: _resource_record_pre_action 22:01:42 INFO - Running main action method: install 22:01:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:01:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:01:42 INFO - Reading from file tmpfile_stdout 22:01:42 INFO - Detecting whether we're running mozinstall >=1.0... 22:01:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:01:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:01:42 INFO - Reading from file tmpfile_stdout 22:01:42 INFO - Output received: 22:01:42 INFO - Usage: mozinstall [options] installer 22:01:42 INFO - Options: 22:01:42 INFO - -h, --help show this help message and exit 22:01:42 INFO - -d DEST, --destination=DEST 22:01:42 INFO - Directory to install application into. [default: 22:01:42 INFO - "/builds/slave/test-pgo"] 22:01:42 INFO - --app=APP Application being installed. [default: firefox] 22:01:42 INFO - mkdir: /builds/slave/test-pgo/build/application 22:01:42 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'] 22:01:42 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 22:01:57 INFO - Reading from file tmpfile_stdout 22:01:57 INFO - Output received: 22:01:57 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:01:57 INFO - Running post-action listener: _resource_record_post_action 22:01:57 INFO - ##### 22:01:57 INFO - ##### Running run-tests step. 22:01:57 INFO - ##### 22:01:57 INFO - Running pre-action listener: _resource_record_pre_action 22:01:57 INFO - Running main action method: run_tests 22:01:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:01:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:01:57 INFO - Python 2.7.3 22:01:57 INFO - Return code: 0 22:01:57 INFO - grabbing minidump binary from tooltool 22:01:57 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')]} 22:01:57 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 0x25af8c0>, '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 0x255c420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255c8b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:01:57 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 22:01:57 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 22:01:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:01:57 INFO - Return code: 0 22:01:57 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:01:57 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:01:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:01:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:01:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:01:57 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 22:01:57 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost 22:01:57 INFO - Using env: {'DISPLAY': ':0', 22:01:57 INFO - 'HOME': '/home/cltbld', 22:01:57 INFO - 'LANG': 'en_US.UTF-8', 22:01:57 INFO - 'LANGUAGE': 'en_US:en', 22:01:57 INFO - 'LOGNAME': 'cltbld', 22:01:57 INFO - 'MAIL': '/var/mail/cltbld', 22:01:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:01:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:57 INFO - 'MOZ_NO_REMOTE': '1', 22:01:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:57 INFO - 'NO_EM_RESTART': '1', 22:01:57 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:57 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:57 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:01:57 INFO - 'SHELL': '/bin/bash', 22:01:57 INFO - 'SHLVL': '1', 22:01:57 INFO - 'TERM': 'linux', 22:01:57 INFO - 'TMOUT': '86400', 22:01:57 INFO - 'USER': 'cltbld', 22:01:57 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1447738109.840296-1726088214', 22:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:57 INFO - '_': '/tools/buildbot/bin/python'} 22:01:57 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost'] with output_timeout 3600 22:01:57 INFO - mozversion INFO | application_buildid: 20151116203312 22:01:57 INFO - mozversion INFO | application_changeset: ffdc7f22130425020f5d648ef99c10b947541659 22:01:57 INFO - mozversion INFO | application_display_name: Nightly 22:01:57 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:01:57 INFO - mozversion INFO | application_name: Firefox 22:01:57 INFO - mozversion INFO | application_remotingname: firefox 22:01:57 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 22:01:57 INFO - mozversion INFO | application_vendor: Mozilla 22:01:57 INFO - mozversion INFO | application_version: 45.0a1 22:01:57 INFO - mozversion INFO | platform_buildid: 20151116203312 22:01:57 INFO - mozversion INFO | platform_changeset: ffdc7f22130425020f5d648ef99c10b947541659 22:01:57 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 22:01:57 INFO - mozversion INFO | platform_version: 45.0a1 22:01:57 INFO - 2015-11-16 22:01:57,375 DEBUG : using testdate: 1447740117 22:01:57 INFO - 2015-11-16 22:01:57,375 DEBUG : actual date: 1447740117 22:01:57 INFO - 2015-11-16 22:01:57,384 INFO : starting webserver on 'localhost:44431' 22:01:57 INFO - 2015-11-16 22:01:57,385 INFO : Starting test suite talos-linux64-ix-004.e 22:01:57 INFO - 2015-11-16 22:01:57,385 INFO : Starting test dromaeo_css 22:01:57 INFO - 2015-11-16 22:01:57,385 DEBUG : operating with platform_type : linux_ 22:01:57 INFO - 2015-11-16 22:01:57,386 INFO : Initialising browser for dromaeo_css test... 22:01:57 INFO - 2015-11-16 22:01:57,399 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIh2SxX/profile http://localhost:44431/getInfo.html 22:02:01 INFO - 2015-11-16 22:02:01,742 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:02:01 INFO - 2015-11-16 22:02:01,742 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:02:01 INFO - 2015-11-16 22:02:01,742 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:02:01 INFO - 2015-11-16 22:02:01,742 DEBUG : BROWSER_OUTPUT: __metrics 22:02:02 INFO - 2015-11-16 22:02:02,761 INFO : Browser initialized. 22:02:02 INFO - 2015-11-16 22:02:02,761 INFO : Running cycle 1/1 for dromaeo_css test... 22:02:02 INFO - 2015-11-16 22:02:02,762 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIh2SxX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:02:14 INFO - 2015-11-16 22:02:14,518 DEBUG : BROWSER_OUTPUT: RSS: Main: 140992512 22:02:14 INFO - 2015-11-16 22:02:14,518 DEBUG : BROWSER_OUTPUT: 22:03:04 INFO - 2015-11-16 22:03:04,158 DEBUG : BROWSER_OUTPUT: 1447740184154 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] 22:05:12 INFO - 2015-11-16 22:05:12,831 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44431/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44431/tests/dromaeo/cssquery-ext.html) 22:05:14 INFO - 2015-11-16 22:05:14,098 DEBUG : BROWSER_OUTPUT: RSS: Main: 146870272 22:05:14 INFO - 2015-11-16 22:05:14,098 DEBUG : BROWSER_OUTPUT: 22:08:16 INFO - 2015-11-16 22:08:16,019 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44431/tests/dromaeo/cssquery-ext.html (next: http://localhost:44431/tests/dromaeo/cssquery-jquery.html) 22:08:16 INFO - 2015-11-16 22:08:16,594 DEBUG : BROWSER_OUTPUT: RSS: Main: 140513280 22:08:16 INFO - 2015-11-16 22:08:16,594 DEBUG : BROWSER_OUTPUT: 22:11:18 INFO - 2015-11-16 22:11:18,283 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44431/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44431/tests/dromaeo/cssquery-mootools.html) 22:11:18 INFO - 2015-11-16 22:11:18,869 DEBUG : BROWSER_OUTPUT: RSS: Main: 142155776 22:11:18 INFO - 2015-11-16 22:11:18,869 DEBUG : BROWSER_OUTPUT: 22:14:20 INFO - 2015-11-16 22:14:20,539 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44431/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44431/tests/dromaeo/cssquery-prototype.html) 22:14:21 INFO - 2015-11-16 22:14:21,139 DEBUG : BROWSER_OUTPUT: RSS: Main: 139321344 22:14:21 INFO - 2015-11-16 22:14:21,140 DEBUG : BROWSER_OUTPUT: 22:17:23 INFO - 2015-11-16 22:17:23,469 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44431/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44431/tests/dromaeo/cssquery-yui.html) 22:17:24 INFO - 2015-11-16 22:17:24,055 DEBUG : BROWSER_OUTPUT: RSS: Main: 140939264 22:17:24 INFO - 2015-11-16 22:17:24,055 DEBUG : BROWSER_OUTPUT: 22:20:26 INFO - 2015-11-16 22:20:26,305 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44431/tests/dromaeo/cssquery-yui.html (next: http://localhost:44431/tests/dromaeo/cssquery-dojo.html) 22:20:26 INFO - 2015-11-16 22:20:26,555 DEBUG : BROWSER_OUTPUT: RSS: Main: 143618048 22:20:26 INFO - 2015-11-16 22:20:26,555 DEBUG : BROWSER_OUTPUT: 22:20:26 INFO - 2015-11-16 22:20:26,556 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:20:26 INFO - 2015-11-16 22:20:26,557 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:20:26 INFO - 2015-11-16 22:20:26,557 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:20:26 INFO - 2015-11-16 22:20:26,557 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:20:26 INFO - 2015-11-16 22:20:26,558 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3220.855061522232;3248.13924310058;3283.11355933898;3325.4679251319794;3333.59996800384;5375.220593014021;5392.541633961113;5411.621186516945;5422.4306447823;5426.131818908975;5449.209864569635;5452.4274951130055;5493.862653433666;5502.779888804453;5506.80726174584;4979.452260251379;5001.599872010249;5032.572231360339;5115.386153661566;5116.974415127919;4976.776045077981;4983.352164218664;4986.975065124688;5045.217991211368;5078.542931136197;4914.04176185644;4957.380327459067;5029.84910452687;5074.67014644047;5088.7964481420695;5001.924971125436;5010.473900240495;5015.598752099823;5023.120953833101;5057.645964782467;4830.058138662962;4966.776495057731;4996.100701873661;5012.198048312289;5040.243963405482;5216.7913283468615;5233.607479439057;5308.867278318035;5313.840584782424;5337.626366154371;5927.8221653350465;5930;5936.168936348915;5946.375630558772;5951.137085122633;5801.564882633819;5915.763369465216;5959.284885813687;5960.165576819249;5983.042713165873;5428.294321738149;5458.808941687062;5477.698726570077;5494.532964697965;5504.587155963319;6040.184575082396;6066.726997285133;6094.8171554853425;6096.207493025879;6105;5679.488846003796;5795.072788353843;5802.506786923074;5924.377940316204;5933.554983376178;5771.9711401443565;5810.331811841608;5827.650340979555;5836.620619659709;5873.3245676746865;5939.4951429129005;5976.581639285208;5983.072623743326;6001.639901605918;6011.248593925759;5720.713964301768;5770.538356931435;5840.503557197686;5979.641221526722;5985.22192115031;4620.930686039712;4621.745803980813;4627.120847039052;4636.11913736389;4652.302154676758;4103.548609652936;4123.567025462343;4124.092699606082;4131.958680413218;4165.875023749292;5517.227588137664;5554.527865131509;5658.434156584309;5696.031674615326;5726.4273572642405;5900.055991041499;5905.645661260338;5932.080527518242;5953.226080609493;5980.13288073227;5587.3015873015875;5590.552755779528;5600.159976003632;5606.775728970877;5618.43815618443;5008.17365134756;5100.566451851634;5101.336826212569;5101.489851014869;5165.715885626251;5997.310309314485;6063.6664983426335;6069.453749162597;6079.75680972765;6113.602615830046;5928.733207005609;6056.273247210363;6070.6357618543025;6075.27096748393;6087.299960504599;6032.33644299118;6130;6219.47134493555;6261;6290.339514350927;5805.129230615442;5815.94184058154;5861.912071319019;5862.413758624274;5897.557683173865;5991.281046274475;5992;5994.250718660168;6029.3669164737075;6042.90935635957;5659.066254068032;5712.6286791358425;5732.885342293047;5887.646741195542;5903.203067585992;5597.160425936142;5678.2050512929045;5690.2887139107615;5729;5791.305043394819;5722.141678748221;5756.136579513107;5766.942330576809;5776.075827867521;5796.101604251347;5746.741396637245;5841.766329346779;5882.647041177543;5890;5928.79249226275;5554.444555544414;5649.6327738696855;5655.123455864347;5658.349289831722;5695.658260504383 22:20:26 INFO - 2015-11-16 22:20:26,562 DEBUG : BROWSER_OUTPUT: |1;ext.html;560.0702833296725;593.3147214966714;598.67671457413;602.5059451249974;609.3145211636909;36020;36517.99999999996;36569.81715091428;36615.08462288444;36754.44868326974;40895.59104408955;41668.16663666732;41761.373579396255;41767.37348939768;41876.58123418765;8701.869471957942;8856.778580535474;8875.511846848422;8893.466392016468;8910.153535414125;8645.52449615271;8736.301095912311;8739.300855931542;8773.824523509526;8775.297976161924;8734.475931444134;8881.689140880071;8882.644694212224;8884.244839188677;8907.109289071073;8729.432586881863;8743.256823170039;8807.691730789391;8812.823743525158;8818.470891746483;8596.613152408157;8711.651533938635;8730.646749753798;8733.170348816851;8791.692290769792;38511.8074409629;38687.8065609673;38972.610273897466;39142.80428597867;39188;3294.1929227339215;3336.6830151135605;3339.465685490334;3681.7790932543867;4074.2869997750277;29200.41599168005;29353.559696604567;29538.70461295381;30580.84709576438;30647.540286895714;3461.463473161664;3472.73954453417;3489.94765078524;3504.421770407905;3538;279144;281271.99999999796;281272;281285;282155.2659337806;41869.79065104655;42385.57614423878;42454.57545424568;57798.4220157793;58074.7096264516;40862.18275634471;41076.58923410787;41139.0633124027;41382.37926431106;41498.79250603728;14954;15201.315940782692;15206.847931520542;15250.694986100216;15282.159481228638;12097.637070887888;12146.392680365947;12150.331731754839;12151.210171338835;12182.81725774114;14149.929250353682;14236.501722439665;14252;14282.785758213635;14351.067180633225;5755.194272801811;5803.303603567514;5856.677882716492;5934.584579079509;5941.643501389931;994.5434776103014;1020.6223697232072;1044.6552637629563;1067.6796960911695;1105.0441368216434;29395.55906661402;29457.852710736308;32832.83583582067;32878.67121328804;33199;1034.6999370182714;1039.656913218636;1066.2110038571402;1067.6743593204146;1108.3903852880883;15395.769063464057;15547.689046219013;15730.606734831721;15757.763633545506;15840.44558440449;380465;385450;385635;386496;389187;55230.44769552253;55489;55599.72200138973;55774.16338754922;55833.441665582824;1357.7623915814693;1359.1233654293123;1363.3319673360181;1364.201941864001;1371.8833899118488;28393.43213135767;29409.85295073511;29410;29750.404991899606;30039.849800750857;47099.52900470951;47654;48256;48262.75868620635;48409.27386089141;304889;305760;307094;308017;308779;33641.495377569845;46887;47308.52691473041;47619.76190119027;48007.75996119997;45253.09493810171;45369.689879461395;45452.54547454483;45506;45627;37545.43681844829;37941.62058379492;38623.613763862;38763.2247355057;39476.605233948445;38724.22551548897;38727.419088713126;38933.72950390613;39580.60419395769;39820.2035959285;37514;37800.43299350457;37922.24155516819;38102;41014.38478422767;32332.676673232967;32538.674613254512;35404.11489712778;35527.82236088803;37255.81372093122;26211.082612108483;26826.19521414361;27275;28179.71820281853;28790 22:20:26 INFO - 2015-11-16 22:20:26,562 DEBUG : BROWSER_OUTPUT: |2;jquery.html;350.1404053049763;353.4203905594825;353.65695275582686;354.4169840612194;355.4738986300276;12596;12975.22148671078;17132.82867171328;17883.910580447096;18882.622347553057;12490.875091249085;12509.749805003918;12741.426635801388;12777.936110319459;12788.36058197091;4547.522510136438;4580.290055041474;4661.347411362412;4706.035262771124;4714.387129673155;4619.769011549426;4629.189891768944;4632.050429661928;4664.953350466503;4674.0651869626045;4633.2818413146015;4634.6987445816085;4646.3727396801505;4823.589994850442;4947.084789313971;4871.756412179377;4874.439439464471;4880.097182021337;4903.68126071806;4913.385826771653;4204.1591681663485;4258.680598955059;4259.1268789897995;4265.232258193524;4296.37702533131;13856.168629882239;13879.722405551933;14144.36350364236;14169.716605667829;14203.715925681428;1990;2027.7833300020018;2047.2936836791282;2120.1095539873136;2150.967735483969;9951.950240248752;9975.25185611082;9987.400755954593;10128.594856205744;10382.636607718769;1719.8882072665238;1741.5907261793468;1742.947711568655;1771.4154329071375;1785.9196336164903;62066.68966655183;63769;64011.359886401005;64571.354286457004;64774.676126619066;6866.690998905061;6930.44556435484;7072.823179420556;7119.71521139159;7152.570845749167;8484.703035393855;8504.744857654281;8506.702265420805;8509.064002959669;8513.829723405497;5572.721363931787;5575.944240557624;5577.749001294951;5605;5610.242617246701;5625.8593535161945;5636.436356364331;5641.548676105902;5695.117256825199;5715.514181294637;3259.5925509311337;3274.6561611030975;3306.338732253511;3311.8012919224925;3318.8008719476907;1167.311286341063;1168.7428765671539;1178.0987544528443;1180.4097951024487;1221.572449642618;398.6611380326699;493.1468559392271;502.4949925325025;514.5060741687946;516.7338820507366;11338.943305283421;11645.941770291094;11697.2981621103;11908.106891983136;12026.518939242333;504.73249177935753;510.6553076673305;511.05199854270535;512.9820456284012;516.576830831058;6278.623282603058;6538.411542961157;6569.277379488252;6732.360425759545;6744.7976560703255;521923;538501;545288;546796;550546;77466.61266693744;79917.60041199757;80048;80159;81647.591762042;562.5668235458755;567.1889198446179;568.2697733412627;568.7639629553771;570.3697414357158;11039.613613523488;11092.168087393638;11180.763847230424;11282.379469129277;11412.201145919706;34512.48231276583;35454.46818297676;35782.46326305055;36303;36351.63648363482;44576.10847783091;47083.29375059308;47879.5212047889;48731.26903096386;49655;6535.2811190768025;6693.899591506229;6696.397324240842;6700.83247918806;6815.727370905108;12922.224666520038;12979.28613926243;13019.218846869218;13053.34733263352;13169.736605268032;11034.834477483004;11078.279911805706;11167;11486.82769758471;11547.422628868355;8510.659573616986;9968;10630;10982.670519884416;11052.171087168656;11022.50398732075;11026.44867756593;11166.44167791591;11215.55137794479;11240.213185076966;6695.0626912231355;6709.463242940651;6723.193216814014;6771.424428923597;6771.898421523582;10283.382997020202;10469.528871200662;10488.05607495329;10618.946905265424;10834.620788272372 22:20:26 INFO - 2015-11-16 22:20:26,565 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1503.030545298282;1715.897046177229;1765.3821162593094;1779.0926627420013;1784.2416972786566;7535.09578850538;7681.65432555535;7791.3377362924075;7944.324732397746;7955.880661790078;7813.765587032384;7852.568108754031;7918.406119541043;7935.325497332734;7947.403944704141;2187.157944191486;2207.2164381644525;2219.04581030157;2219.9223027194053;2222.0112050137695;2290.541891621674;2310.6534019897067;2313.3175713164574;2315.7684231576877;2324.6164382876805;2205.911763529465;2256.6953461282765;2257.2325409360815;2275.055851821492;2303.355060583031;2214.8449608527408;2277.407873952784;2290.6678531612824;2311.791938725506;2315.0855412112205;2263.9886800566055;2298.862068275892;2302.838801283911;2305.250793492105;2307.2501437033034;7782.883256751154;7834.686612535492;7852.882206766903;7860.135385107634;7866.410019248579;4573.519780423074;4638.281066434674;4678.532146785328;4701.858944231679;4713.057388522275;3071.984640076785;3138.168385377877;3187.6493585705553;3188.0595224408853;3205.102571280022;1031.6131450705984;1050.1388861133873;1050.317293759055;1065.2862582070031;1865.337805079191;10541.894581054168;10566.31318964265;10570.260081794355;10597.84103238452;10613.57545698171;4008.7394319369146;4014.0767623446186;4061.248668996245;4255.510616279105;4258.467691538558;8515.82968340642;8584.227419532148;8591.742247732578;8602.612882420306;8639.95680021596;4604.7927843247135;4609.354690343354;4621.491635920046;4622.838200662961;4642.65180111493;4218.156368726267;4225.9788701056295;4236.08924081324;4249.490061192677;4271.10306835568;3402.727781777452;3454.240067185215;3456.1186897341017;3460.3079384123275;3469.6356882527475;1047.44977433399;1059.4173204737363;1067.4716015572342;1070.7216123807866;1072.0726571515584;974.7611835100304;979.1677074486772;1116.6929094499078;1163.976720465603;1285.53720660564;6997.510174287751;7146.178189508273;7152.177499587614;7154.248803875622;7177.210506844243;713.3686687281793;716.1263258824226;718.335539625844;725.760499035317;831.6590198018783;5673.120666296731;5773.480386765212;5774.422557744192;5776.075827867521;5804.448577385142;8593.570321483901;8678.305735541142;9013.414128081653;9122.635094596142;9223.49270790113;9168.541572921327;9204.309676774268;9220.907790922005;9264.258859291376;9304.209142222986;7168.462365322622;7234.276572342724;7309.4152467803515;7310.4151667866445;7324.340809327186;7229.385502232369;7230.096237970254;7271.745488907863;7291.52605080668;7298.817529561803;8046.87929681067;8276.131006244257;8290.834183316421;8307.792305192419;8404.075551689188;8421;8531.189536993976;8553.529555874487;8557.871631925651;8581.528015959182;6628.7017084230365;6754.054432379569;6822.351876571718;6882.827929301808;6992.545484543692;7509.812254693677;7545.849083018418;7548.735794247175;7564.50830696003;7588.354989825706;6935;7060.046893669289;7116.3951064158055;7201.207867134506;7253.528520646141;6615.6030638161865;6765.221999470124;6833.384995350243;6903.1371078615175;7048.823779405556;7125.5368401053765;7188.17336006366;7196.784096477114;7197.71209151628;7243.20324764286;6405.551611387158;6543.967280163569;6557.311482294291;6560.671966401756;6574.309697481695;6674.466042716474;6688.063671085954;6696.899546506904;6707.530472867048;6714.7314107437105 22:20:26 INFO - 2015-11-16 22:20:26,569 DEBUG : BROWSER_OUTPUT: |4;prototype.html;330.21903198934496;331.3257520944877;337.6353538178766;338.5125419396071;339.5806179368479;6262.84342891428;6313.4317911388025;6393.168888044548;6430.389113034266;6560.212774467059;6342.112104305401;6387.616742995424;6404.327545607703;6417.90373144402;6421.839454013652;4809.519048095198;4813.6389770767155;4814.253790662453;4814.518548145193;4824.8552543423575;4824.662273640846;4827.8310259140935;4829.830955916544;4832.347633069543;4838.395200599925;4629.421322334708;4650.581447669709;4709.434867815867;4725.432948046222;4732.124556956974;4750.738709370983;4759.714417134983;4766.785494652749;4767.284907263921;4780.856574302777;4092.5498195198506;4096.9795151024355;4104.56902025289;4112.444819949328;4150.501939767217;5920.79277225295;5959.255093113361;5965.373635768268;5965.70171491428;5990.341062483123;5486.231927530149;5566.415526369713;5572.86067848303;5573.721313934328;5583.190437386556;6709.49678774089;6718.49611279156;6721.1598550181225;6724.058631791553;6725.730970761213;4553.362529245908;4579.977100114512;4591.49493555712;4593.839215627437;4597.908041839144;6837.179538455417;6935.237123916365;6948.513604047719;6949.652517374111;7032.331928466788;4680.789364478606;4686.320483529869;4687.10944920464;4697.671163018625;4701.670883038223;4736.431628204568;4736.478987311393;4745.359376484131;4745.786439610226;4759.23852183649;5537.556995440355;5538;5549.916751248735;5551.805686800943;5561.138023606348;6580.703868325937;6687.465002799764;6707.932920670828;6724.798256052326;6809.114815074008;1658.038337764094;1679.554917946745;1680.546252511815;1688.0968681755448;1690.6280618263963;1107.8172101603307;1110.722319420145;1113.7271368514603;1114.3815182573587;1133.0708818768696;6474.287828338879;6504.902426463606;6506.926357151017;6511.479081673455;6537.757826013138;6918.135233095863;6983.301669832976;7006.859862802716;7018.2630823762765;7019.473539484559;6368.904466433008;6479.6760161991715;6511.316311787289;6564.835879102965;6579.638119903451;3800.3539398302355;3822.464854920258;3824.8661296854475;3848.1534062506203;3850.2492014057552;7343.751562234433;7363.521371110861;7374.9262507375315;7386.667599957907;7397.593132377771;7118.71525138999;7253.129624444995;7261.164966028869;7278.454115941326;7327.230640782747;7273.745418910313;7340.192578816326;7350.228226036296;7355.190928997806;7368.078990126127;6936.653167341512;7029.753958611424;7053.435725141873;7068.257832927468;7087.114110736158;6900.309969003059;6982.1272340957385;6986.54587451814;6991.580505169706;6994;7334.193238743841;7359.742409015659;7371.557706537625;7377.409807215303;7382.187959324578;4681.578657920803;4707.223308154116;4720.244760838249;4723.952760472352;4731.219348807408;6835.658217089225;6972.895406569007;7005.859882802417;7093.716251349888;7122.145342558926;6881.243063262937;6881.41507971828;6896.7586134485055;6911.239763626098;6911.308869113049;6685.53201275906;6835.692393842389;6847.93152068473;6861.1080559526945;6879.793606191823;6750.223724271772;6753.831154221184;6759.459243260626;6763.729450822108;6765.594064356154;6906.620135892374;6909.481788865754;6909.7581584646305;6913.3777959983845;6915.962605609199;6508.869822603616;6657.467402607683;6668.699908504032;6703.363180497845;6711.060451536887 22:20:26 INFO - 2015-11-16 22:20:26,570 DEBUG : BROWSER_OUTPUT: |5;yui.html;718.5688586847889;737.8081698758322;777.199484530933;844.2654890245487;854.6581367453018;13878.097923634956;14202.360893759793;14240.074395164307;14327.283635818194;14418.06282591632;13516.594502164951;13814.240216788072;13875.583732488041;13924.373403196854;13939.721205575908;783.2011348424603;784.3137254901961;784.701813310941;792.762171348596;813.9796505087361;808.3533173461237;822.4777266435797;823.5758584329076;823.5840900345318;826.6528058215564;854.1245223645782;855.6962278391175;858.6050416808275;859.1065292096213;861.2464093917822;848.2238751542332;849.087231226434;850.9404341696084;853.0914575976597;853.6158728572167;617.0497433951709;617.2068891474433;619.767587154817;619.9566030377875;621.1831441654256;13406.329683515884;13448.193108413428;13486.730265394637;13494.662633434145;13496;10598.311109777916;10643.988821061987;10755.139588832875;11001.119910407228;11262.831057534144;9315.30135239853;9466.242700583936;9475.147236748657;10384.584616615326;10403.479826008745;3180.6501284858646;3218.91952701182;3233.1593785615673;3236.935261294761;3238.5627940228005;45486.77256613729;45782.31326530105;46060.76969615164;46298.53701462976;46303.610891672964;7405.333519983227;7460.962695186598;7477.813054673567;7593.354564861938;7635.809104772314;11976.221545599508;11982.700432489084;11991.460384282727;12014.459349329301;12018.15872888907;6791.4227290679855;6912.377885990285;7020.684069216897;7188.353048225685;7330.450216233804;4257.340112282601;4299.78501074945;4360.127974405132;4368.344748287719;4375.6280716138845;2727.5499542575253;2755.5728862026417;2760.8343499390103;2761.199252216835;2765.14280573023;425.7892343290091;430.5715812766318;430.6963590668571;430.7566225082881;511.0315951272318;559.7117484495407;633.8954072578065;644.2108417188999;651.7165033210474;670.8289386206584;8117.797055073553;8463.619137138843;8575.3997220194;8641;8847.380683352232;508.12095075519557;683.4839696029566;689.3601782587943;709.0746575718737;716.6130289643638;4024.436578878959;4095.6313931746286;4194.748315101043;4381.978090109593;4403.097365040223;57691.711541442026;58098;58182;58315.708421457624;58433;50502.49497505051;51271.48728512742;51283.99999999925;51459.48540514622;51776.48223517792;43283.783581081894;43512.12975740531;43862.684119476464;44253.114937701066;47309.52690473051;8347.332213422791;8484;8966.506842123747;9077.546122693706;9127.178553930178;32676.83661581772;33297.500537492444;33657.65369385197;34040.31919361649;34424.655753442144;42739.145217096106;43492.56507434885;43790.34314485222;44067.55932440634;44463.77768111139;7984.441089123706;7989.880151797612;8221.753347399588;8266.710665126691;8424.157584241526;12016.819747703617;12155.453004614637;12178.330191839534;12395.008399327851;12798.744025119631;11033.393163376091;11129.16531260175;11370.488328025423;11769.52921883115;11863.584774533196;10830.458477076272;10971;11190;11497.94251028773;11613.245139065933;10066.647667331608;10574.365538067741;10762.677119686421;10836.187285953427;11196.104311654884;9211.907880921373;9229.400088994194;9312.534373281173;9337.346385753204;9402.059794020817;8336.291415229773;8672.349573781865;8744.213020828156;8813.603387847434;9339.346245763003 22:20:26 INFO - 2015-11-16 22:20:26,570 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:20:26 INFO - 2015-11-16 22:20:26,570 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:20:26 INFO - 2015-11-16 22:20:26,570 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,286 22:20:26 INFO - 2015-11-16 22:20:26,570 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:20:26 INFO - 2015-11-16 22:20:26,571 DEBUG : BROWSER_OUTPUT: __startTimestamp1447741226555__endTimestamp 22:20:26 INFO - 2015-11-16 22:20:26,571 DEBUG : BROWSER_OUTPUT: 22:20:26 INFO - 2015-11-16 22:20:26,571 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:20:26 INFO - 2015-11-16 22:20:26,571 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:20:26 INFO - 2015-11-16 22:20:26,571 DEBUG : BROWSER_OUTPUT: 22:20:26 INFO - 2015-11-16 22:20:26,571 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5495.24 Median:5695.66 stddev:613.68 (10.8%) stddev-sans-first:589.05 22:20:26 INFO - 2015-11-16 22:20:26,571 DEBUG : BROWSER_OUTPUT: Values: 3220.9 3248.1 3283.1 3325.5 3333.6 5375.2 5392.5 5411.6 5422.4 5426.1 5449.2 5452.4 5493.9 5502.8 5506.8 4979.5 5001.6 5032.6 5115.4 5117.0 4976.8 4983.4 4987.0 5045.2 5078.5 4914.0 4957.4 5029.8 5074.7 5088.8 5001.9 5010.5 5015.6 5023.1 5057.6 4830.1 4966.8 4996.1 5012.2 5040.2 5216.8 5233.6 5308.9 5313.8 5337.6 5927.8 5930.0 5936.2 5946.4 5951.1 5801.6 5915.8 5959.3 5960.2 5983.0 5428.3 5458.8 5477.7 5494.5 5504.6 6040.2 6066.7 6094.8 6096.2 6105.0 5679.5 5795.1 5802.5 5924.4 5933.6 5772.0 5810.3 5827.7 5836.6 5873.3 5939.5 5976.6 5983.1 6001.6 6011.2 5720.7 5770.5 5840.5 5979.6 5985.2 4620.9 4621.7 4627.1 4636.1 4652.3 4103.5 4123.6 4124.1 4132.0 4165.9 5517.2 5554.5 5658.4 5696.0 5726.4 5900.1 5905.6 5932.1 5953.2 5980.1 5587.3 5590.6 5600.2 5606.8 5618.4 5008.2 5100.6 5101.3 5101.5 5165.7 5997.3 6063.7 6069.5 6079.8 6113.6 5928.7 6056.3 6070.6 6075.3 6087.3 6032.3 6130.0 6219.5 6261.0 6290.3 5805.1 5815.9 5861.9 5862.4 5897.6 5991.3 5992.0 5994.3 6029.4 6042.9 5659.1 5712.6 5732.9 5887.6 5903.2 5597.2 5678.2 5690.3 5729.0 5791.3 5722.1 5756.1 5766.9 5776.1 5796.1 5746.7 5841.8 5882.6 5890.0 5928.8 5554.4 5649.6 5655.1 5658.3 5695.7 22:20:26 INFO - 2015-11-16 22:20:26,571 DEBUG : BROWSER_OUTPUT: 22:20:26 INFO - 2015-11-16 22:20:26,571 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48912.49 Median:38306.90 stddev:85917.67 (224.3%) stddev-sans-first:86081.99 22:20:26 INFO - 2015-11-16 22:20:26,571 DEBUG : BROWSER_OUTPUT: Values: 560.1 593.3 598.7 602.5 609.3 36020.0 36518.0 36569.8 36615.1 36754.4 40895.6 41668.2 41761.4 41767.4 41876.6 8701.9 8856.8 8875.5 8893.5 8910.2 8645.5 8736.3 8739.3 8773.8 8775.3 8734.5 8881.7 8882.6 8884.2 8907.1 8729.4 8743.3 8807.7 8812.8 8818.5 8596.6 8711.7 8730.6 8733.2 8791.7 38511.8 38687.8 38972.6 39142.8 39188.0 3294.2 3336.7 3339.5 3681.8 4074.3 29200.4 29353.6 29538.7 30580.8 30647.5 3461.5 3472.7 3489.9 3504.4 3538.0 279144.0 281272.0 281272.0 281285.0 282155.3 41869.8 42385.6 42454.6 57798.4 58074.7 40862.2 41076.6 41139.1 41382.4 41498.8 14954.0 15201.3 15206.8 15250.7 15282.2 12097.6 12146.4 12150.3 12151.2 12182.8 14149.9 14236.5 14252.0 14282.8 14351.1 5755.2 5803.3 5856.7 5934.6 5941.6 994.5 1020.6 1044.7 1067.7 1105.0 29395.6 29457.9 32832.8 32878.7 33199.0 1034.7 1039.7 1066.2 1067.7 1108.4 15395.8 15547.7 15730.6 15757.8 15840.4 380465.0 385450.0 385635.0 386496.0 389187.0 55230.4 55489.0 55599.7 55774.2 55833.4 1357.8 1359.1 1363.3 1364.2 1371.9 28393.4 29409.9 29410.0 29750.4 30039.8 47099.5 47654.0 48256.0 48262.8 48409.3 304889.0 305760.0 307094.0 308017.0 308779.0 33641.5 46887.0 47308.5 47619.8 48007.8 45253.1 45369.7 45452.5 45506.0 45627.0 37545.4 37941.6 38623.6 38763.2 39476.6 38724.2 38727.4 38933.7 39580.6 39820.2 37514.0 37800.4 37922.2 38102.0 41014.4 32332.7 32538.7 35404.1 35527.8 37255.8 26211.1 26826.2 27275.0 28179.7 28790.0 22:20:26 INFO - 2015-11-16 22:20:26,572 DEBUG : BROWSER_OUTPUT: 22:20:26 INFO - 2015-11-16 22:20:26,572 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27209.29 Median:4630.62 stddev:88716.86 (1915.9%) stddev-sans-first:88942.81 22:20:26 INFO - 2015-11-16 22:20:26,572 DEBUG : BROWSER_OUTPUT: Values: 350.1 353.4 353.7 354.4 355.5 12596.0 12975.2 17132.8 17883.9 18882.6 12490.9 12509.7 12741.4 12777.9 12788.4 4547.5 4580.3 4661.3 4706.0 4714.4 4619.8 4629.2 4632.1 4665.0 4674.1 4633.3 4634.7 4646.4 4823.6 4947.1 4871.8 4874.4 4880.1 4903.7 4913.4 4204.2 4258.7 4259.1 4265.2 4296.4 13856.2 13879.7 14144.4 14169.7 14203.7 1990.0 2027.8 2047.3 2120.1 2151.0 9952.0 9975.3 9987.4 10128.6 10382.6 1719.9 1741.6 1742.9 1771.4 1785.9 62066.7 63769.0 64011.4 64571.4 64774.7 6866.7 6930.4 7072.8 7119.7 7152.6 8484.7 8504.7 8506.7 8509.1 8513.8 5572.7 5575.9 5577.7 5605.0 5610.2 5625.9 5636.4 5641.5 5695.1 5715.5 3259.6 3274.7 3306.3 3311.8 3318.8 1167.3 1168.7 1178.1 1180.4 1221.6 398.7 493.1 502.5 514.5 516.7 11338.9 11645.9 11697.3 11908.1 12026.5 504.7 510.7 511.1 513.0 516.6 6278.6 6538.4 6569.3 6732.4 6744.8 521923.0 538501.0 545288.0 546796.0 550546.0 77466.6 79917.6 80048.0 80159.0 81647.6 562.6 567.2 568.3 568.8 570.4 11039.6 11092.2 11180.8 11282.4 11412.2 34512.5 35454.5 35782.5 36303.0 36351.6 44576.1 47083.3 47879.5 48731.3 49655.0 6535.3 6693.9 6696.4 6700.8 6815.7 12922.2 12979.3 13019.2 13053.3 13169.7 11034.8 11078.3 11167.0 11486.8 11547.4 8510.7 9968.0 10630.0 10982.7 11052.2 11022.5 11026.4 11166.4 11215.6 11240.2 6695.1 6709.5 6723.2 6771.4 6771.9 10283.4 10469.5 10488.1 10618.9 10834.6 22:20:26 INFO - 2015-11-16 22:20:26,572 DEBUG : BROWSER_OUTPUT: 22:20:26 INFO - 2015-11-16 22:20:26,572 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5422.74 Median:6681.26 stddev:2797.29 (41.9%) stddev-sans-first:2789.63 22:20:26 INFO - 2015-11-16 22:20:26,573 DEBUG : BROWSER_OUTPUT: Values: 1503.0 1715.9 1765.4 1779.1 1784.2 7535.1 7681.7 7791.3 7944.3 7955.9 7813.8 7852.6 7918.4 7935.3 7947.4 2187.2 2207.2 2219.0 2219.9 2222.0 2290.5 2310.7 2313.3 2315.8 2324.6 2205.9 2256.7 2257.2 2275.1 2303.4 2214.8 2277.4 2290.7 2311.8 2315.1 2264.0 2298.9 2302.8 2305.3 2307.3 7782.9 7834.7 7852.9 7860.1 7866.4 4573.5 4638.3 4678.5 4701.9 4713.1 3072.0 3138.2 3187.6 3188.1 3205.1 1031.6 1050.1 1050.3 1065.3 1865.3 10541.9 10566.3 10570.3 10597.8 10613.6 4008.7 4014.1 4061.2 4255.5 4258.5 8515.8 8584.2 8591.7 8602.6 8640.0 4604.8 4609.4 4621.5 4622.8 4642.7 4218.2 4226.0 4236.1 4249.5 4271.1 3402.7 3454.2 3456.1 3460.3 3469.6 1047.4 1059.4 1067.5 1070.7 1072.1 974.8 979.2 1116.7 1164.0 1285.5 6997.5 7146.2 7152.2 7154.2 7177.2 713.4 716.1 718.3 725.8 831.7 5673.1 5773.5 5774.4 5776.1 5804.4 8593.6 8678.3 9013.4 9122.6 9223.5 9168.5 9204.3 9220.9 9264.3 9304.2 7168.5 7234.3 7309.4 7310.4 7324.3 7229.4 7230.1 7271.7 7291.5 7298.8 8046.9 8276.1 8290.8 8307.8 8404.1 8421.0 8531.2 8553.5 8557.9 8581.5 6628.7 6754.1 6822.4 6882.8 6992.5 7509.8 7545.8 7548.7 7564.5 7588.4 6935.0 7060.0 7116.4 7201.2 7253.5 6615.6 6765.2 6833.4 6903.1 7048.8 7125.5 7188.2 7196.8 7197.7 7243.2 6405.6 6544.0 6557.3 6560.7 6574.3 6674.5 6688.1 6696.9 6707.5 6714.7 22:20:26 INFO - 2015-11-16 22:20:26,573 DEBUG : BROWSER_OUTPUT: 22:20:26 INFO - 2015-11-16 22:20:26,573 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5652.43 Median:6476.98 stddev:1745.66 (27.0%) stddev-sans-first:1704.23 22:20:26 INFO - 2015-11-16 22:20:26,573 DEBUG : BROWSER_OUTPUT: Values: 330.2 331.3 337.6 338.5 339.6 6262.8 6313.4 6393.2 6430.4 6560.2 6342.1 6387.6 6404.3 6417.9 6421.8 4809.5 4813.6 4814.3 4814.5 4824.9 4824.7 4827.8 4829.8 4832.3 4838.4 4629.4 4650.6 4709.4 4725.4 4732.1 4750.7 4759.7 4766.8 4767.3 4780.9 4092.5 4097.0 4104.6 4112.4 4150.5 5920.8 5959.3 5965.4 5965.7 5990.3 5486.2 5566.4 5572.9 5573.7 5583.2 6709.5 6718.5 6721.2 6724.1 6725.7 4553.4 4580.0 4591.5 4593.8 4597.9 6837.2 6935.2 6948.5 6949.7 7032.3 4680.8 4686.3 4687.1 4697.7 4701.7 4736.4 4736.5 4745.4 4745.8 4759.2 5537.6 5538.0 5549.9 5551.8 5561.1 6580.7 6687.5 6707.9 6724.8 6809.1 1658.0 1679.6 1680.5 1688.1 1690.6 1107.8 1110.7 1113.7 1114.4 1133.1 6474.3 6504.9 6506.9 6511.5 6537.8 6918.1 6983.3 7006.9 7018.3 7019.5 6368.9 6479.7 6511.3 6564.8 6579.6 3800.4 3822.5 3824.9 3848.2 3850.2 7343.8 7363.5 7374.9 7386.7 7397.6 7118.7 7253.1 7261.2 7278.5 7327.2 7273.7 7340.2 7350.2 7355.2 7368.1 6936.7 7029.8 7053.4 7068.3 7087.1 6900.3 6982.1 6986.5 6991.6 6994.0 7334.2 7359.7 7371.6 7377.4 7382.2 4681.6 4707.2 4720.2 4724.0 4731.2 6835.7 6972.9 7005.9 7093.7 7122.1 6881.2 6881.4 6896.8 6911.2 6911.3 6685.5 6835.7 6847.9 6861.1 6879.8 6750.2 6753.8 6759.5 6763.7 6765.6 6906.6 6909.5 6909.8 6913.4 6916.0 6508.9 6657.5 6668.7 6703.4 6711.1 22:20:26 INFO - 2015-11-16 22:20:26,574 DEBUG : BROWSER_OUTPUT: 22:20:26 INFO - 2015-11-16 22:20:26,574 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13225.25 Median:48906.01 stddev:15720.48 (32.1%) stddev-sans-first:15736.52 22:20:26 INFO - 2015-11-16 22:20:26,575 DEBUG : BROWSER_OUTPUT: Values: 718.6 737.8 777.2 844.3 854.7 13878.1 14202.4 14240.1 14327.3 14418.1 13516.6 13814.2 13875.6 13924.4 13939.7 783.2 784.3 784.7 792.8 814.0 808.4 822.5 823.6 823.6 826.7 854.1 855.7 858.6 859.1 861.2 848.2 849.1 850.9 853.1 853.6 617.0 617.2 619.8 620.0 621.2 13406.3 13448.2 13486.7 13494.7 13496.0 10598.3 10644.0 10755.1 11001.1 11262.8 9315.3 9466.2 9475.1 10384.6 10403.5 3180.7 3218.9 3233.2 3236.9 3238.6 45486.8 45782.3 46060.8 46298.5 46303.6 7405.3 7461.0 7477.8 7593.4 7635.8 11976.2 11982.7 11991.5 12014.5 12018.2 6791.4 6912.4 7020.7 7188.4 7330.5 4257.3 4299.8 4360.1 4368.3 4375.6 2727.5 2755.6 2760.8 2761.2 2765.1 425.8 430.6 430.7 430.8 511.0 559.7 633.9 644.2 651.7 670.8 8117.8 8463.6 8575.4 8641.0 8847.4 508.1 683.5 689.4 709.1 716.6 4024.4 4095.6 4194.7 4382.0 4403.1 57691.7 58098.0 58182.0 58315.7 58433.0 50502.5 51271.5 51284.0 51459.5 51776.5 43283.8 43512.1 43862.7 44253.1 47309.5 8347.3 8484.0 8966.5 9077.5 9127.2 32676.8 33297.5 33657.7 34040.3 34424.7 42739.1 43492.6 43790.3 44067.6 44463.8 7984.4 7989.9 8221.8 8266.7 8424.2 12016.8 12155.5 12178.3 12395.0 12798.7 11033.4 11129.2 11370.5 11769.5 11863.6 10830.5 10971.0 11190.0 11497.9 11613.2 10066.6 10574.4 10762.7 10836.2 11196.1 9211.9 9229.4 9312.5 9337.3 9402.1 8336.3 8672.3 8744.2 8813.6 9339.3 22:20:26 INFO - 2015-11-16 22:20:26,575 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:20:26 INFO - 2015-11-16 22:20:26,575 DEBUG : BROWSER_OUTPUT: 22:20:27 INFO - 2015-11-16 22:20:27,233 INFO : Browser exited with error code: 0 22:20:27 INFO - 2015-11-16 22:20:27,257 INFO : Completed test dromaeo_css (00:18:29) 22:20:27 INFO - 2015-11-16 22:20:27,257 INFO : Starting test kraken 22:20:27 INFO - 2015-11-16 22:20:27,257 DEBUG : operating with platform_type : linux_ 22:20:27 INFO - 2015-11-16 22:20:27,257 INFO : Initialising browser for kraken test... 22:20:27 INFO - 2015-11-16 22:20:27,263 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPQvZAL/profile http://localhost:44431/getInfo.html 22:20:31 INFO - 2015-11-16 22:20:31,703 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:20:31 INFO - 2015-11-16 22:20:31,704 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:20:31 INFO - 2015-11-16 22:20:31,704 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:20:31 INFO - 2015-11-16 22:20:31,704 DEBUG : BROWSER_OUTPUT: __metrics 22:20:32 INFO - 2015-11-16 22:20:32,729 INFO : Browser initialized. 22:20:32 INFO - 2015-11-16 22:20:32,729 INFO : Running cycle 1/1 for kraken test... 22:20:32 INFO - 2015-11-16 22:20:32,730 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPQvZAL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:20:44 INFO - 2015-11-16 22:20:44,510 DEBUG : BROWSER_OUTPUT: RSS: Main: 140623872 22:20:44 INFO - 2015-11-16 22:20:44,511 DEBUG : BROWSER_OUTPUT: 22:20:47 INFO - 2015-11-16 22:20:47,008 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44431/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44431/tests/kraken/driver.html?testName=audio-beat-detection) 22:20:47 INFO - 2015-11-16 22:20:47,614 DEBUG : BROWSER_OUTPUT: RSS: Main: 140824576 22:20:47 INFO - 2015-11-16 22:20:47,614 DEBUG : BROWSER_OUTPUT: 22:20:50 INFO - 2015-11-16 22:20:50,279 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44431/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44431/tests/kraken/driver.html?testName=audio-dft) 22:20:50 INFO - 2015-11-16 22:20:50,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 139759616 22:20:50 INFO - 2015-11-16 22:20:50,881 DEBUG : BROWSER_OUTPUT: 22:20:53 INFO - 2015-11-16 22:20:53,720 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44431/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44431/tests/kraken/driver.html?testName=audio-fft) 22:20:54 INFO - 2015-11-16 22:20:54,305 DEBUG : BROWSER_OUTPUT: RSS: Main: 135602176 22:20:54 INFO - 2015-11-16 22:20:54,305 DEBUG : BROWSER_OUTPUT: 22:20:56 INFO - 2015-11-16 22:20:56,327 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44431/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44431/tests/kraken/driver.html?testName=audio-oscillator) 22:20:56 INFO - 2015-11-16 22:20:56,912 DEBUG : BROWSER_OUTPUT: RSS: Main: 136519680 22:20:56 INFO - 2015-11-16 22:20:56,912 DEBUG : BROWSER_OUTPUT: 22:20:59 INFO - 2015-11-16 22:20:59,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44431/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44431/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:20:59 INFO - 2015-11-16 22:20:59,684 DEBUG : BROWSER_OUTPUT: RSS: Main: 137035776 22:20:59 INFO - 2015-11-16 22:20:59,684 DEBUG : BROWSER_OUTPUT: 22:21:02 INFO - 2015-11-16 22:21:02,690 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44431/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44431/tests/kraken/driver.html?testName=imaging-darkroom) 22:21:03 INFO - 2015-11-16 22:21:03,276 DEBUG : BROWSER_OUTPUT: RSS: Main: 136794112 22:21:03 INFO - 2015-11-16 22:21:03,277 DEBUG : BROWSER_OUTPUT: 22:21:06 INFO - 2015-11-16 22:21:06,698 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44431/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44431/tests/kraken/driver.html?testName=imaging-desaturate) 22:21:07 INFO - 2015-11-16 22:21:07,281 DEBUG : BROWSER_OUTPUT: RSS: Main: 138244096 22:21:07 INFO - 2015-11-16 22:21:07,282 DEBUG : BROWSER_OUTPUT: 22:21:10 INFO - 2015-11-16 22:21:10,131 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44431/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44431/tests/kraken/driver.html?testName=json-parse-financial) 22:21:10 INFO - 2015-11-16 22:21:10,720 DEBUG : BROWSER_OUTPUT: RSS: Main: 139137024 22:21:10 INFO - 2015-11-16 22:21:10,720 DEBUG : BROWSER_OUTPUT: 22:21:12 INFO - 2015-11-16 22:21:12,317 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44431/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44431/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:21:12 INFO - 2015-11-16 22:21:12,898 DEBUG : BROWSER_OUTPUT: RSS: Main: 138174464 22:21:12 INFO - 2015-11-16 22:21:12,898 DEBUG : BROWSER_OUTPUT: 22:21:14 INFO - 2015-11-16 22:21:14,749 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44431/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44431/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:21:15 INFO - 2015-11-16 22:21:15,359 DEBUG : BROWSER_OUTPUT: RSS: Main: 139194368 22:21:15 INFO - 2015-11-16 22:21:15,359 DEBUG : BROWSER_OUTPUT: 22:21:17 INFO - 2015-11-16 22:21:17,451 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44431/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44431/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:21:18 INFO - 2015-11-16 22:21:18,038 DEBUG : BROWSER_OUTPUT: RSS: Main: 139374592 22:21:18 INFO - 2015-11-16 22:21:18,038 DEBUG : BROWSER_OUTPUT: 22:21:20 INFO - 2015-11-16 22:21:20,534 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44431/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44431/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:21:21 INFO - 2015-11-16 22:21:21,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 139890688 22:21:21 INFO - 2015-11-16 22:21:21,136 DEBUG : BROWSER_OUTPUT: 22:21:23 INFO - 2015-11-16 22:21:23,711 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44431/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44431/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:21:24 INFO - 2015-11-16 22:21:24,297 DEBUG : BROWSER_OUTPUT: RSS: Main: 138756096 22:21:24 INFO - 2015-11-16 22:21:24,297 DEBUG : BROWSER_OUTPUT: 22:21:25 INFO - 2015-11-16 22:21:25,978 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44431/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44431/tests/kraken/driver.html?testName=ai-astar) 22:21:26 INFO - 2015-11-16 22:21:26,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 139145216 22:21:26 INFO - 2015-11-16 22:21:26,228 DEBUG : BROWSER_OUTPUT: 22:21:26 INFO - 2015-11-16 22:21:26,231 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:21:26 INFO - 2015-11-16 22:21:26,231 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:21:26 INFO - 2015-11-16 22:21:26,231 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:21:26 INFO - 2015-11-16 22:21:26,232 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:21:26 INFO - 2015-11-16 22:21:26,232 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;105;113;111;111;126;113;111;114;111 22:21:26 INFO - 2015-11-16 22:21:26,232 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;170;125;153;162;127;155;149;133;165;125 22:21:26 INFO - 2015-11-16 22:21:26,232 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;161;163;163;165;163;165;170;165 22:21:26 INFO - 2015-11-16 22:21:26,232 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;71;152;73;72;71;72;156;72 22:21:26 INFO - 2015-11-16 22:21:26,232 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;90;140;90;91;91;138;90;91;140 22:21:26 INFO - 2015-11-16 22:21:26,232 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;111;113;110;111;111;110;110 22:21:26 INFO - 2015-11-16 22:21:26,232 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;147;146;147;146;146;146;146;148 22:21:26 INFO - 2015-11-16 22:21:26,232 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;97;95;96;97;96;97;96;96 22:21:26 INFO - 2015-11-16 22:21:26,232 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;61;62;63;63;63;64;66;60;60 22:21:26 INFO - 2015-11-16 22:21:26,232 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;68;69;69;69;71;77;68;70;69 22:21:26 INFO - 2015-11-16 22:21:26,233 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;87;92;86;87;83;85;85;84;84 22:21:26 INFO - 2015-11-16 22:21:26,233 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;120;121;126;134;124;127;122;120;116 22:21:26 INFO - 2015-11-16 22:21:26,233 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;153;151;142;144;153;151;148;158;140 22:21:26 INFO - 2015-11-16 22:21:26,233 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;69;69;69;69;65;66;66;69;70 22:21:26 INFO - 2015-11-16 22:21:26,233 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:21:26 INFO - 2015-11-16 22:21:26,233 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:21:26 INFO - 2015-11-16 22:21:26,233 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,712 22:21:26 INFO - 2015-11-16 22:21:26,233 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:21:26 INFO - 2015-11-16 22:21:26,233 DEBUG : BROWSER_OUTPUT: __startTimestamp1447741286230__endTimestamp 22:21:26 INFO - 2015-11-16 22:21:26,233 DEBUG : BROWSER_OUTPUT: 22:21:26 INFO - 2015-11-16 22:21:26,236 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:21:26 INFO - 2015-11-16 22:21:26,236 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:21:26 INFO - 2015-11-16 22:21:26,237 DEBUG : BROWSER_OUTPUT: 22:21:26 INFO - 2015-11-16 22:21:26,237 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:5.28 (4.7%) stddev-sans-first:5.59 22:21:26 INFO - 2015-11-16 22:21:26,237 DEBUG : BROWSER_OUTPUT: Values: 114.0 105.0 113.0 111.0 111.0 126.0 113.0 111.0 114.0 111.0 22:21:26 INFO - 2015-11-16 22:21:26,237 DEBUG : BROWSER_OUTPUT: 22:21:26 INFO - 2015-11-16 22:21:26,237 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.40 Median:154.00 stddev:17.46 (11.3%) stddev-sans-first:16.29 22:21:26 INFO - 2015-11-16 22:21:26,237 DEBUG : BROWSER_OUTPUT: Values: 170.0 125.0 153.0 162.0 127.0 155.0 149.0 133.0 165.0 125.0 22:21:26 INFO - 2015-11-16 22:21:26,237 DEBUG : BROWSER_OUTPUT: 22:21:26 INFO - 2015-11-16 22:21:26,237 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:2.56 (1.6%) stddev-sans-first:2.62 22:21:26 INFO - 2015-11-16 22:21:26,237 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 161.0 163.0 163.0 165.0 163.0 165.0 170.0 165.0 22:21:26 INFO - 2015-11-16 22:21:26,237 DEBUG : BROWSER_OUTPUT: 22:21:26 INFO - 2015-11-16 22:21:26,237 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.40 Median:72.00 stddev:34.59 (48.0%) stddev-sans-first:36.18 22:21:26 INFO - 2015-11-16 22:21:26,237 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 71.0 152.0 73.0 72.0 71.0 72.0 156.0 72.0 22:21:26 INFO - 2015-11-16 22:21:26,238 DEBUG : BROWSER_OUTPUT: 22:21:26 INFO - 2015-11-16 22:21:26,238 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.10 Median:90.00 stddev:23.63 (26.3%) stddev-sans-first:24.43 22:21:26 INFO - 2015-11-16 22:21:26,238 DEBUG : BROWSER_OUTPUT: Values: 90.0 90.0 140.0 90.0 91.0 91.0 138.0 90.0 91.0 140.0 22:21:26 INFO - 2015-11-16 22:21:26,238 DEBUG : BROWSER_OUTPUT: 22:21:26 INFO - 2015-11-16 22:21:26,238 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.50 Median:110.50 stddev:1.08 (1.0%) stddev-sans-first:1.13 22:21:26 INFO - 2015-11-16 22:21:26,238 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 111.0 113.0 110.0 111.0 111.0 110.0 110.0 22:21:26 INFO - 2015-11-16 22:21:26,238 DEBUG : BROWSER_OUTPUT: 22:21:26 INFO - 2015-11-16 22:21:26,239 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 22:21:26 INFO - 2015-11-16 22:21:26,239 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 148.0 22:21:26 INFO - 2015-11-16 22:21:26,239 DEBUG : BROWSER_OUTPUT: 22:21:26 INFO - 2015-11-16 22:21:26,239 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 22:21:26 INFO - 2015-11-16 22:21:26,239 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 97.0 95.0 96.0 97.0 96.0 97.0 96.0 96.0 22:21:26 INFO - 2015-11-16 22:21:26,239 DEBUG : BROWSER_OUTPUT: 22:21:26 INFO - 2015-11-16 22:21:26,239 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.30 Median:63.00 stddev:1.89 (3.0%) stddev-sans-first:1.94 22:21:26 INFO - 2015-11-16 22:21:26,239 DEBUG : BROWSER_OUTPUT: Values: 61.0 61.0 62.0 63.0 63.0 63.0 64.0 66.0 60.0 60.0 22:21:26 INFO - 2015-11-16 22:21:26,240 DEBUG : BROWSER_OUTPUT: 22:21:26 INFO - 2015-11-16 22:21:26,240 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:69.00 stddev:2.64 (3.8%) stddev-sans-first:2.78 22:21:26 INFO - 2015-11-16 22:21:26,240 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 69.0 69.0 69.0 71.0 77.0 68.0 70.0 69.0 22:21:26 INFO - 2015-11-16 22:21:26,240 DEBUG : BROWSER_OUTPUT: 22:21:26 INFO - 2015-11-16 22:21:26,240 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:86.00 stddev:2.51 (2.9%) stddev-sans-first:2.67 22:21:26 INFO - 2015-11-16 22:21:26,240 DEBUG : BROWSER_OUTPUT: Values: 86.0 87.0 92.0 86.0 87.0 83.0 85.0 85.0 84.0 84.0 22:21:26 INFO - 2015-11-16 22:21:26,240 DEBUG : BROWSER_OUTPUT: 22:21:26 INFO - 2015-11-16 22:21:26,240 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.00 Median:125.00 stddev:5.35 (4.3%) stddev-sans-first:5.22 22:21:26 INFO - 2015-11-16 22:21:26,240 DEBUG : BROWSER_OUTPUT: Values: 130.0 120.0 121.0 126.0 134.0 124.0 127.0 122.0 120.0 116.0 22:21:26 INFO - 2015-11-16 22:21:26,240 DEBUG : BROWSER_OUTPUT: 22:21:26 INFO - 2015-11-16 22:21:26,240 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.50 Median:151.00 stddev:5.68 (3.8%) stddev-sans-first:5.88 22:21:26 INFO - 2015-11-16 22:21:26,240 DEBUG : BROWSER_OUTPUT: Values: 145.0 153.0 151.0 142.0 144.0 153.0 151.0 148.0 158.0 140.0 22:21:26 INFO - 2015-11-16 22:21:26,241 DEBUG : BROWSER_OUTPUT: 22:21:26 INFO - 2015-11-16 22:21:26,241 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:69.00 stddev:1.70 (2.5%) stddev-sans-first:1.80 22:21:26 INFO - 2015-11-16 22:21:26,241 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 69.0 69.0 65.0 66.0 66.0 69.0 70.0 22:21:26 INFO - 2015-11-16 22:21:26,241 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:21:26 INFO - 2015-11-16 22:21:26,241 DEBUG : BROWSER_OUTPUT: 22:21:27 INFO - 2015-11-16 22:21:27,165 INFO : Browser exited with error code: 0 22:21:27 INFO - 2015-11-16 22:21:27,218 INFO : Completed test kraken (00:00:59) 22:21:27 INFO - 2015-11-16 22:21:27,218 INFO : Starting test v8_7 22:21:27 INFO - 2015-11-16 22:21:27,218 DEBUG : operating with platform_type : linux_ 22:21:27 INFO - 2015-11-16 22:21:27,218 INFO : Initialising browser for v8_7 test... 22:21:27 INFO - 2015-11-16 22:21:27,224 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpivm4fV/profile http://localhost:44431/getInfo.html 22:21:31 INFO - 2015-11-16 22:21:31,318 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:21:31 INFO - 2015-11-16 22:21:31,319 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:21:31 INFO - 2015-11-16 22:21:31,319 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:21:31 INFO - 2015-11-16 22:21:31,319 DEBUG : BROWSER_OUTPUT: __metrics 22:21:32 INFO - 2015-11-16 22:21:32,357 INFO : Browser initialized. 22:21:32 INFO - 2015-11-16 22:21:32,357 INFO : Running cycle 1/1 for v8_7 test... 22:21:32 INFO - 2015-11-16 22:21:32,358 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpivm4fV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:21:44 INFO - 2015-11-16 22:21:44,134 DEBUG : BROWSER_OUTPUT: RSS: Main: 141045760 22:21:44 INFO - 2015-11-16 22:21:44,134 DEBUG : BROWSER_OUTPUT: 22:22:05 INFO - 2015-11-16 22:22:05,521 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44431/tests/v8_7/run.html (next: http://localhost:44431/tests/v8_7/run.html) 22:22:05 INFO - 2015-11-16 22:22:05,772 DEBUG : BROWSER_OUTPUT: RSS: Main: 138207232 22:22:05 INFO - 2015-11-16 22:22:05,772 DEBUG : BROWSER_OUTPUT: 22:22:05 INFO - 2015-11-16 22:22:05,773 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:22:05 INFO - 2015-11-16 22:22:05,773 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:22:05 INFO - 2015-11-16 22:22:05,773 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:22:05 INFO - 2015-11-16 22:22:05,773 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:22:05 INFO - 2015-11-16 22:22:05,774 DEBUG : BROWSER_OUTPUT: |0;Richards;162.73393002441009 22:22:05 INFO - 2015-11-16 22:22:05,774 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.71779141104295 22:22:05 INFO - 2015-11-16 22:22:05,774 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.42624789680315 22:22:05 INFO - 2015-11-16 22:22:05,774 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5065.656565656565 22:22:05 INFO - 2015-11-16 22:22:05,774 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1052.6315789473683 22:22:05 INFO - 2015-11-16 22:22:05,774 DEBUG : BROWSER_OUTPUT: |5;Earley;720.9805335255949 22:22:05 INFO - 2015-11-16 22:22:05,774 DEBUG : BROWSER_OUTPUT: |6;Boyer;12240.963855421687 22:22:05 INFO - 2015-11-16 22:22:05,775 DEBUG : BROWSER_OUTPUT: |7;RegExp;25550 22:22:05 INFO - 2015-11-16 22:22:05,775 DEBUG : BROWSER_OUTPUT: |8;Splay;629.6758104738154 22:22:05 INFO - 2015-11-16 22:22:05,775 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 22:22:05 INFO - 2015-11-16 22:22:05,775 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:22:05 INFO - 2015-11-16 22:22:05,775 DEBUG : BROWSER_OUTPUT: __startTimestamp1447741325772__endTimestamp 22:22:05 INFO - 2015-11-16 22:22:05,775 DEBUG : BROWSER_OUTPUT: 22:22:05 INFO - 2015-11-16 22:22:05,777 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:22:05 INFO - 2015-11-16 22:22:05,777 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:22:05 INFO - 2015-11-16 22:22:05,777 DEBUG : BROWSER_OUTPUT: 22:22:05 INFO - 2015-11-16 22:22:05,777 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.73 Median:162.73 stddev:0.00 (0.0%) 22:22:05 INFO - 2015-11-16 22:22:05,777 DEBUG : BROWSER_OUTPUT: Values: 162.7 22:22:05 INFO - 2015-11-16 22:22:05,777 DEBUG : BROWSER_OUTPUT: 22:22:05 INFO - 2015-11-16 22:22:05,777 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.72 Median:191.72 stddev:0.00 (0.0%) 22:22:05 INFO - 2015-11-16 22:22:05,778 DEBUG : BROWSER_OUTPUT: Values: 191.7 22:22:05 INFO - 2015-11-16 22:22:05,778 DEBUG : BROWSER_OUTPUT: 22:22:05 INFO - 2015-11-16 22:22:05,778 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.43 Median:280.43 stddev:0.00 (0.0%) 22:22:05 INFO - 2015-11-16 22:22:05,778 DEBUG : BROWSER_OUTPUT: Values: 280.4 22:22:05 INFO - 2015-11-16 22:22:05,778 DEBUG : BROWSER_OUTPUT: 22:22:05 INFO - 2015-11-16 22:22:05,778 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5065.66 Median:5065.66 stddev:0.00 (0.0%) 22:22:05 INFO - 2015-11-16 22:22:05,778 DEBUG : BROWSER_OUTPUT: Values: 5065.7 22:22:05 INFO - 2015-11-16 22:22:05,779 DEBUG : BROWSER_OUTPUT: 22:22:05 INFO - 2015-11-16 22:22:05,779 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1052.63 Median:1052.63 stddev:0.00 (0.0%) 22:22:05 INFO - 2015-11-16 22:22:05,779 DEBUG : BROWSER_OUTPUT: Values: 1052.6 22:22:05 INFO - 2015-11-16 22:22:05,779 DEBUG : BROWSER_OUTPUT: 22:22:05 INFO - 2015-11-16 22:22:05,779 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:720.98 Median:720.98 stddev:0.00 (0.0%) 22:22:05 INFO - 2015-11-16 22:22:05,779 DEBUG : BROWSER_OUTPUT: Values: 721.0 22:22:05 INFO - 2015-11-16 22:22:05,779 DEBUG : BROWSER_OUTPUT: 22:22:05 INFO - 2015-11-16 22:22:05,779 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12240.96 Median:12240.96 stddev:0.00 (0.0%) 22:22:05 INFO - 2015-11-16 22:22:05,780 DEBUG : BROWSER_OUTPUT: Values: 12241.0 22:22:05 INFO - 2015-11-16 22:22:05,780 DEBUG : BROWSER_OUTPUT: 22:22:05 INFO - 2015-11-16 22:22:05,780 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25550.00 Median:25550.00 stddev:0.00 (0.0%) 22:22:05 INFO - 2015-11-16 22:22:05,780 DEBUG : BROWSER_OUTPUT: Values: 25550.0 22:22:05 INFO - 2015-11-16 22:22:05,780 DEBUG : BROWSER_OUTPUT: 22:22:05 INFO - 2015-11-16 22:22:05,780 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:629.68 Median:629.68 stddev:0.00 (0.0%) 22:22:05 INFO - 2015-11-16 22:22:05,780 DEBUG : BROWSER_OUTPUT: Values: 629.7 22:22:05 INFO - 2015-11-16 22:22:05,781 DEBUG : BROWSER_OUTPUT: 22:22:05 INFO - 2015-11-16 22:22:05,781 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 22:22:05 INFO - 2015-11-16 22:22:05,781 DEBUG : BROWSER_OUTPUT: Values: 4840.6 22:22:05 INFO - 2015-11-16 22:22:05,781 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:22:05 INFO - 2015-11-16 22:22:05,781 DEBUG : BROWSER_OUTPUT: 22:22:06 INFO - 2015-11-16 22:22:06,661 INFO : Browser exited with error code: 0 22:22:06 INFO - 2015-11-16 22:22:06,678 INFO : Completed test v8_7 (00:00:39) 22:22:06 INFO - 2015-11-16 22:22:06,819 INFO : Completed test suite (00:20:09) 22:22:06 INFO - 2015-11-16 22:22:06,820 DEBUG : Working with test: dromaeo_css 22:22:06 INFO - 2015-11-16 22:22:06,820 DEBUG : Generating results file: dromaeo_css 22:22:06 INFO - 2015-11-16 22:22:06,821 DEBUG : Working with test: kraken 22:22:06 INFO - 2015-11-16 22:22:06,821 DEBUG : Generating results file: kraken 22:22:06 INFO - 2015-11-16 22:22:06,821 INFO : javascript benchmark 22:22:06 INFO - 2015-11-16 22:22:06,821 DEBUG : Working with test: v8_7 22:22:06 INFO - 2015-11-16 22:22:06,822 DEBUG : Generating results file: v8_7 22:22:06 INFO - 2015-11-16 22:22:06,822 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:22:06 INFO - 2015-11-16 22:22:06,882 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 22:22:06 INFO - 2015-11-16 22:22:06,883 DEBUG : process_Request line: dromaeo_css 6759.94 graph.html#tests=[[72,64,43]] 22:22:06 INFO - 2015-11-16 22:22:06,883 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:22:06 INFO - 2015-11-16 22:22:06,924 DEBUG : process_Request line: kraken 1528.50 graph.html#tests=[[232,64,43]] 22:22:06 INFO - 2015-11-16 22:22:06,925 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:22:06 INFO - 2015-11-16 22:22:06,970 DEBUG : process_Request line: v8_7 21323.73 graph.html#tests=[[230,64,43]] 22:22:06 INFO - 2015-11-16 22:22:06,971 INFO : javascript benchmark 22:22:07 INFO - 2015-11-16 22:22:06,975 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [350.1404053049763, 353.4203905594825, 353.65695275582686, 354.4169840612194, 355.4738986300276, 12596.0, 12975.22148671078, 17132.82867171328, 17883.910580447096, 18882.622347553057, 12490.875091249085, 12509.749805003918, 12741.426635801388, 12777.936110319459, 12788.36058197091, 4547.522510136438, 4580.290055041474, 4661.347411362412, 4706.035262771124, 4714.387129673155, 4619.769011549426, 4629.189891768944, 4632.050429661928, 4664.953350466503, 4674.0651869626045, 4633.2818413146015, 4634.6987445816085, 4646.3727396801505, 4823.589994850442, 4947.084789313971, 4871.756412179377, 4874.439439464471, 4880.097182021337, 4903.68126071806, 4913.385826771653, 4204.1591681663485, 4258.680598955059, 4259.1268789897995, 4265.232258193524, 4296.37702533131, 13856.168629882239, 13879.722405551933, 14144.36350364236, 14169.716605667829, 14203.715925681428, 1990.0, 2027.7833300020018, 2047.2936836791282, 2120.1095539873136, 2150.967735483969, 9951.950240248752, 9975.25185611082, 9987.400755954593, 10128.594856205744, 10382.636607718769, 1719.8882072665238, 1741.5907261793468, 1742.947711568655, 1771.4154329071375, 1785.9196336164903, 62066.68966655183, 63769.0, 64011.359886401005, 64571.354286457004, 64774.676126619066, 6866.690998905061, 6930.44556435484, 7072.823179420556, 7119.71521139159, 7152.570845749167, 8484.703035393855, 8504.744857654281, 8506.702265420805, 8509.064002959669, 8513.829723405497, 5572.721363931787, 5575.944240557624, 5577.749001294951, 5605.0, 5610.242617246701, 5625.8593535161945, 5636.436356364331, 5641.548676105902, 5695.117256825199, 5715.514181294637, 3259.5925509311337, 3274.6561611030975, 3306.338732253511, 3311.8012919224925, 3318.8008719476907, 1167.311286341063, 1168.7428765671539, 1178.0987544528443, 1180.4097951024487, 1221.572449642618, 398.6611380326699, 493.1468559392271, 502.4949925325025, 514.5060741687946, 516.7338820507366, 11338.943305283421, 11645.941770291094, 11697.2981621103, 11908.106891983136, 12026.518939242333, 504.73249177935753, 510.6553076673305, 511.05199854270535, 512.9820456284012, 516.576830831058, 6278.623282603058, 6538.411542961157, 6569.277379488252, 6732.360425759545, 6744.7976560703255, 521923.0, 538501.0, 545288.0, 546796.0, 550546.0, 77466.61266693744, 79917.60041199757, 80048.0, 80159.0, 81647.591762042, 562.5668235458755, 567.1889198446179, 568.2697733412627, 568.7639629553771, 570.3697414357158, 11039.613613523488, 11092.168087393638, 11180.763847230424, 11282.379469129277, 11412.201145919706, 34512.48231276583, 35454.46818297676, 35782.46326305055, 36303.0, 36351.63648363482, 44576.10847783091, 47083.29375059308, 47879.5212047889, 48731.26903096386, 49655.0, 6535.2811190768025, 6693.899591506229, 6696.397324240842, 6700.83247918806, 6815.727370905108, 12922.224666520038, 12979.28613926243, 13019.218846869218, 13053.34733263352, 13169.736605268032, 11034.834477483004, 11078.279911805706, 11167.0, 11486.82769758471, 11547.422628868355, 8510.659573616986, 9968.0, 10630.0, 10982.670519884416, 11052.171087168656, 11022.50398732075, 11026.44867756593, 11166.44167791591, 11215.55137794479, 11240.213185076966, 6695.0626912231355, 6709.463242940651, 6723.193216814014, 6771.424428923597, 6771.898421523582, 10283.382997020202, 10469.528871200662, 10488.05607495329, 10618.946905265424, 10834.620788272372], "dojo.html": [3220.855061522232, 3248.13924310058, 3283.11355933898, 3325.4679251319794, 3333.59996800384, 5375.220593014021, 5392.541633961113, 5411.621186516945, 5422.4306447823, 5426.131818908975, 5449.209864569635, 5452.4274951130055, 5493.862653433666, 5502.779888804453, 5506.80726174584, 4979.452260251379, 5001.599872010249, 5032.572231360339, 5115.386153661566, 5116.974415127919, 4976.776045077981, 4983.352164218664, 4986.975065124688, 5045.217991211368, 5078.542931136197, 4914.04176185644, 4957.380327459067, 5029.84910452687, 5074.67014644047, 5088.7964481420695, 5001.924971125436, 5010.473900240495, 5015.598752099823, 5023.120953833101, 5057.645964782467, 4830.058138662962, 4966.776495057731, 4996.100701873661, 5012.198048312289, 5040.243963405482, 5216.7913283468615, 5233.607479439057, 5308.867278318035, 5313.840584782424, 5337.626366154371, 5927.8221653350465, 5930.0, 5936.168936348915, 5946.375630558772, 5951.137085122633, 5801.564882633819, 5915.763369465216, 5959.284885813687, 5960.165576819249, 5983.042713165873, 5428.294321738149, 5458.808941687062, 5477.698726570077, 5494.532964697965, 5504.587155963319, 6040.184575082396, 6066.726997285133, 6094.8171554853425, 6096.207493025879, 6105.0, 5679.488846003796, 5795.072788353843, 5802.506786923074, 5924.377940316204, 5933.554983376178, 5771.9711401443565, 5810.331811841608, 5827.650340979555, 5836.620619659709, 5873.3245676746865, 5939.4951429129005, 5976.581639285208, 5983.072623743326, 6001.639901605918, 6011.248593925759, 5720.713964301768, 5770.538356931435, 5840.503557197686, 5979.641221526722, 5985.22192115031, 4620.930686039712, 4621.745803980813, 4627.120847039052, 4636.11913736389, 4652.302154676758, 4103.548609652936, 4123.567025462343, 4124.092699606082, 4131.958680413218, 4165.875023749292, 5517.227588137664, 5554.527865131509, 5658.434156584309, 5696.031674615326, 5726.4273572642405, 5900.055991041499, 5905.645661260338, 5932.080527518242, 5953.226080609493, 5980.13288073227, 5587.3015873015875, 5590.552755779528, 5600.159976003632, 5606.775728970877, 5618.43815618443, 5008.17365134756, 5100.566451851634, 5101.336826212569, 5101.489851014869, 5165.715885626251, 5997.310309314485, 6063.6664983426335, 6069.453749162597, 6079.75680972765, 6113.602615830046, 5928.733207005609, 6056.273247210363, 6070.6357618543025, 6075.27096748393, 6087.299960504599, 6032.33644299118, 6130.0, 6219.47134493555, 6261.0, 6290.339514350927, 5805.129230615442, 5815.94184058154, 5861.912071319019, 5862.413758624274, 5897.557683173865, 5991.281046274475, 5992.0, 5994.250718660168, 6029.3669164737075, 6042.90935635957, 5659.066254068032, 5712.6286791358425, 5732.885342293047, 5887.646741195542, 5903.203067585992, 5597.160425936142, 5678.2050512929045, 5690.2887139107615, 5729.0, 5791.305043394819, 5722.141678748221, 5756.136579513107, 5766.942330576809, 5776.075827867521, 5796.101604251347, 5746.741396637245, 5841.766329346779, 5882.647041177543, 5890.0, 5928.79249226275, 5554.444555544414, 5649.6327738696855, 5655.123455864347, 5658.349289831722, 5695.658260504383], "mootools.html": [1503.030545298282, 1715.897046177229, 1765.3821162593094, 1779.0926627420013, 1784.2416972786566, 7535.09578850538, 7681.65432555535, 7791.3377362924075, 7944.324732397746, 7955.880661790078, 7813.765587032384, 7852.568108754031, 7918.406119541043, 7935.325497332734, 7947.403944704141, 2187.157944191486, 2207.2164381644525, 2219.04581030157, 2219.9223027194053, 2222.0112050137695, 2290.541891621674, 2310.6534019897067, 2313.3175713164574, 2315.7684231576877, 2324.6164382876805, 2205.911763529465, 2256.6953461282765, 2257.2325409360815, 2275.055851821492, 2303.355060583031, 2214.8449608527408, 2277.407873952784, 2290.6678531612824, 2311.791938725506, 2315.0855412112205, 2263.9886800566055, 2298.862068275892, 2302.838801283911, 2305.250793492105, 2307.2501437033034, 7782.883256751154, 7834.686612535492, 7852.882206766903, 7860.135385107634, 7866.410019248579, 4573.519780423074, 4638.281066434674, 4678.532146785328, 4701.858944231679, 4713.057388522275, 3071.984640076785, 3138.168385377877, 3187.6493585705553, 3188.0595224408853, 3205.102571280022, 1031.6131450705984, 1050.1388861133873, 1050.317293759055, 1065.2862582070031, 1865.337805079191, 10541.894581054168, 10566.31318964265, 10570.260081794355, 10597.84103238452, 10613.57545698171, 4008.7394319369146, 4014.0767623446186, 4061.248668996245, 4255.510616279105, 4258.467691538558, 8515.82968340642, 8584.227419532148, 8591.742247732578, 8602.612882420306, 8639.95680021596, 4604.7927843247135, 4609.354690343354, 4621.491635920046, 4622.838200662961, 4642.65180111493, 4218.156368726267, 4225.9788701056295, 4236.08924081324, 4249.490061192677, 4271.10306835568, 3402.727781777452, 3454.240067185215, 3456.1186897341017, 3460.3079384123275, 3469.6356882527475, 1047.44977433399, 1059.4173204737363, 1067.4716015572342, 1070.7216123807866, 1072.0726571515584, 974.7611835100304, 979.1677074486772, 1116.6929094499078, 1163.976720465603, 1285.53720660564, 6997.510174287751, 7146.178189508273, 7152.177499587614, 7154.248803875622, 7177.210506844243, 713.3686687281793, 716.1263258824226, 718.335539625844, 725.760499035317, 831.6590198018783, 5673.120666296731, 5773.480386765212, 5774.422557744192, 5776.075827867521, 5804.448577385142, 8593.570321483901, 8678.305735541142, 9013.414128081653, 9122.635094596142, 9223.49270790113, 9168.541572921327, 9204.309676774268, 9220.907790922005, 9264.258859291376, 9304.209142222986, 7168.462365322622, 7234.276572342724, 7309.4152467803515, 7310.4151667866445, 7324.340809327186, 7229.385502232369, 7230.096237970254, 7271.745488907863, 7291.52605080668, 7298.817529561803, 8046.87929681067, 8276.131006244257, 8290.834183316421, 8307.792305192419, 8404.075551689188, 8421.0, 8531.189536993976, 8553.529555874487, 8557.871631925651, 8581.528015959182, 6628.7017084230365, 6754.054432379569, 6822.351876571718, 6882.827929301808, 6992.545484543692, 7509.812254693677, 7545.849083018418, 7548.735794247175, 7564.50830696003, 7588.354989825706, 6935.0, 7060.046893669289, 7116.3951064158055, 7201.207867134506, 7253.528520646141, 6615.6030638161865, 6765.221999470124, 6833.384995350243, 6903.1371078615175, 7048.823779405556, 7125.5368401053765, 7188.17336006366, 7196.784096477114, 7197.71209151628, 7243.20324764286, 6405.551611387158, 6543.967280163569, 6557.311482294291, 6560.671966401756, 6574.309697481695, 6674.466042716474, 6688.063671085954, 6696.899546506904, 6707.530472867048, 6714.7314107437105], "ext.html": [560.0702833296725, 593.3147214966714, 598.67671457413, 602.5059451249974, 609.3145211636909, 36020.0, 36517.99999999996, 36569.81715091428, 36615.08462288444, 36754.44868326974, 40895.59104408955, 41668.16663666732, 41761.373579396255, 41767.37348939768, 41876.58123418765, 8701.869471957942, 8856.778580535474, 8875.511846848422, 8893.466392016468, 8910.153535414125, 8645.52449615271, 8736.301095912311, 8739.300855931542, 8773.824523509526, 8775.297976161924, 8734.475931444134, 8881.689140880071, 8882.644694212224, 8884.244839188677, 8907.109289071073, 8729.432586881863, 8743.256823170039, 8807.691730789391, 8812.823743525158, 8818.470891746483, 8596.613152408157, 8711.651533938635, 8730.646749753798, 8733.170348816851, 8791.692290769792, 38511.8074409629, 38687.8065609673, 38972.610273897466, 39142.80428597867, 39188.0, 3294.1929227339215, 3336.6830151135605, 3339.465685490334, 3681.7790932543867, 4074.2869997750277, 29200.41599168005, 29353.559696604567, 29538.70461295381, 30580.84709576438, 30647.540286895714, 3461.463473161664, 3472.73954453417, 3489.94765078524, 3504.421770407905, 3538.0, 279144.0, 281271.99999999796, 281272.0, 281285.0, 282155.2659337806, 41869.79065104655, 42385.57614423878, 42454.57545424568, 57798.4220157793, 58074.7096264516, 40862.18275634471, 41076.58923410787, 41139.0633124027, 41382.37926431106, 41498.79250603728, 14954.0, 15201.315940782692, 15206.847931520542, 15250.694986100216, 15282.159481228638, 12097.637070887888, 12146.392680365947, 12150.331731754839, 12151.210171338835, 12182.81725774114, 14149.929250353682, 14236.501722439665, 14252.0, 14282.785758213635, 14351.067180633225, 5755.194272801811, 5803.303603567514, 5856.677882716492, 5934.584579079509, 5941.643501389931, 994.5434776103014, 1020.6223697232072, 1044.6552637629563, 1067.6796960911695, 1105.0441368216434, 29395.55906661402, 29457.852710736308, 32832.83583582067, 32878.67121328804, 33199.0, 1034.6999370182714, 1039.656913218636, 1066.2110038571402, 1067.6743593204146, 1108.3903852880883, 15395.769063464057, 15547.689046219013, 15730.606734831721, 15757.763633545506, 15840.44558440449, 380465.0, 385450.0, 385635.0, 386496.0, 389187.0, 55230.44769552253, 55489.0, 55599.72200138973, 55774.16338754922, 55833.441665582824, 1357.7623915814693, 1359.1233654293123, 1363.3319673360181, 1364.201941864001, 1371.8833899118488, 28393.43213135767, 29409.85295073511, 29410.0, 29750.404991899606, 30039.849800750857, 47099.52900470951, 47654.0, 48256.0, 48262.75868620635, 48409.27386089141, 304889.0, 305760.0, 307094.0, 308017.0, 308779.0, 33641.495377569845, 46887.0, 47308.52691473041, 47619.76190119027, 48007.75996119997, 45253.09493810171, 45369.689879461395, 45452.54547454483, 45506.0, 45627.0, 37545.43681844829, 37941.62058379492, 38623.613763862, 38763.2247355057, 39476.605233948445, 38724.22551548897, 38727.419088713126, 38933.72950390613, 39580.60419395769, 39820.2035959285, 37514.0, 37800.43299350457, 37922.24155516819, 38102.0, 41014.38478422767, 32332.676673232967, 32538.674613254512, 35404.11489712778, 35527.82236088803, 37255.81372093122, 26211.082612108483, 26826.19521414361, 27275.0, 28179.71820281853, 28790.0], "prototype.html": [330.21903198934496, 331.3257520944877, 337.6353538178766, 338.5125419396071, 339.5806179368479, 6262.84342891428, 6313.4317911388025, 6393.168888044548, 6430.389113034266, 6560.212774467059, 6342.112104305401, 6387.616742995424, 6404.327545607703, 6417.90373144402, 6421.839454013652, 4809.519048095198, 4813.6389770767155, 4814.253790662453, 4814.518548145193, 4824.8552543423575, 4824.662273640846, 4827.8310259140935, 4829.830955916544, 4832.347633069543, 4838.395200599925, 4629.421322334708, 4650.581447669709, 4709.434867815867, 4725.432948046222, 4732.124556956974, 4750.738709370983, 4759.714417134983, 4766.785494652749, 4767.284907263921, 4780.856574302777, 4092.5498195198506, 4096.9795151024355, 4104.56902025289, 4112.444819949328, 4150.501939767217, 5920.79277225295, 5959.255093113361, 5965.373635768268, 5965.70171491428, 5990.341062483123, 5486.231927530149, 5566.415526369713, 5572.86067848303, 5573.721313934328, 5583.190437386556, 6709.49678774089, 6718.49611279156, 6721.1598550181225, 6724.058631791553, 6725.730970761213, 4553.362529245908, 4579.977100114512, 4591.49493555712, 4593.839215627437, 4597.908041839144, 6837.179538455417, 6935.237123916365, 6948.513604047719, 6949.652517374111, 7032.331928466788, 4680.789364478606, 4686.320483529869, 4687.10944920464, 4697.671163018625, 4701.670883038223, 4736.431628204568, 4736.478987311393, 4745.359376484131, 4745.786439610226, 4759.23852183649, 5537.556995440355, 5538.0, 5549.916751248735, 5551.805686800943, 5561.138023606348, 6580.703868325937, 6687.465002799764, 6707.932920670828, 6724.798256052326, 6809.114815074008, 1658.038337764094, 1679.554917946745, 1680.546252511815, 1688.0968681755448, 1690.6280618263963, 1107.8172101603307, 1110.722319420145, 1113.7271368514603, 1114.3815182573587, 1133.0708818768696, 6474.287828338879, 6504.902426463606, 6506.926357151017, 6511.479081673455, 6537.757826013138, 6918.135233095863, 6983.301669832976, 7006.859862802716, 7018.2630823762765, 7019.473539484559, 6368.904466433008, 6479.6760161991715, 6511.316311787289, 6564.835879102965, 6579.638119903451, 3800.3539398302355, 3822.464854920258, 3824.8661296854475, 3848.1534062506203, 3850.2492014057552, 7343.751562234433, 7363.521371110861, 7374.9262507375315, 7386.667599957907, 7397.593132377771, 7118.71525138999, 7253.129624444995, 7261.164966028869, 7278.454115941326, 7327.230640782747, 7273.745418910313, 7340.192578816326, 7350.228226036296, 7355.190928997806, 7368.078990126127, 6936.653167341512, 7029.753958611424, 7053.435725141873, 7068.257832927468, 7087.114110736158, 6900.309969003059, 6982.1272340957385, 6986.54587451814, 6991.580505169706, 6994.0, 7334.193238743841, 7359.742409015659, 7371.557706537625, 7377.409807215303, 7382.187959324578, 4681.578657920803, 4707.223308154116, 4720.244760838249, 4723.952760472352, 4731.219348807408, 6835.658217089225, 6972.895406569007, 7005.859882802417, 7093.716251349888, 7122.145342558926, 6881.243063262937, 6881.41507971828, 6896.7586134485055, 6911.239763626098, 6911.308869113049, 6685.53201275906, 6835.692393842389, 6847.93152068473, 6861.1080559526945, 6879.793606191823, 6750.223724271772, 6753.831154221184, 6759.459243260626, 6763.729450822108, 6765.594064356154, 6906.620135892374, 6909.481788865754, 6909.7581584646305, 6913.3777959983845, 6915.962605609199, 6508.869822603616, 6657.467402607683, 6668.699908504032, 6703.363180497845, 6711.060451536887], "yui.html": [718.5688586847889, 737.8081698758322, 777.199484530933, 844.2654890245487, 854.6581367453018, 13878.097923634956, 14202.360893759793, 14240.074395164307, 14327.283635818194, 14418.06282591632, 13516.594502164951, 13814.240216788072, 13875.583732488041, 13924.373403196854, 13939.721205575908, 783.2011348424603, 784.3137254901961, 784.701813310941, 792.762171348596, 813.9796505087361, 808.3533173461237, 822.4777266435797, 823.5758584329076, 823.5840900345318, 826.6528058215564, 854.1245223645782, 855.6962278391175, 858.6050416808275, 859.1065292096213, 861.2464093917822, 848.2238751542332, 849.087231226434, 850.9404341696084, 853.0914575976597, 853.6158728572167, 617.0497433951709, 617.2068891474433, 619.767587154817, 619.9566030377875, 621.1831441654256, 13406.329683515884, 13448.193108413428, 13486.730265394637, 13494.662633434145, 13496.0, 10598.311109777916, 10643.988821061987, 10755.139588832875, 11001.119910407228, 11262.831057534144, 9315.30135239853, 9466.242700583936, 9475.147236748657, 10384.584616615326, 10403.479826008745, 3180.6501284858646, 3218.91952701182, 3233.1593785615673, 3236.935261294761, 3238.5627940228005, 45486.77256613729, 45782.31326530105, 46060.76969615164, 46298.53701462976, 46303.610891672964, 7405.333519983227, 7460.962695186598, 7477.813054673567, 7593.354564861938, 7635.809104772314, 11976.221545599508, 11982.700432489084, 11991.460384282727, 12014.459349329301, 12018.15872888907, 6791.4227290679855, 6912.377885990285, 7020.684069216897, 7188.353048225685, 7330.450216233804, 4257.340112282601, 4299.78501074945, 4360.127974405132, 4368.344748287719, 4375.6280716138845, 2727.5499542575253, 2755.5728862026417, 2760.8343499390103, 2761.199252216835, 2765.14280573023, 425.7892343290091, 430.5715812766318, 430.6963590668571, 430.7566225082881, 511.0315951272318, 559.7117484495407, 633.8954072578065, 644.2108417188999, 651.7165033210474, 670.8289386206584, 8117.797055073553, 8463.619137138843, 8575.3997220194, 8641.0, 8847.380683352232, 508.12095075519557, 683.4839696029566, 689.3601782587943, 709.0746575718737, 716.6130289643638, 4024.436578878959, 4095.6313931746286, 4194.748315101043, 4381.978090109593, 4403.097365040223, 57691.711541442026, 58098.0, 58182.0, 58315.708421457624, 58433.0, 50502.49497505051, 51271.48728512742, 51283.99999999925, 51459.48540514622, 51776.48223517792, 43283.783581081894, 43512.12975740531, 43862.684119476464, 44253.114937701066, 47309.52690473051, 8347.332213422791, 8484.0, 8966.506842123747, 9077.546122693706, 9127.178553930178, 32676.83661581772, 33297.500537492444, 33657.65369385197, 34040.31919361649, 34424.655753442144, 42739.145217096106, 43492.56507434885, 43790.34314485222, 44067.55932440634, 44463.77768111139, 7984.441089123706, 7989.880151797612, 8221.753347399588, 8266.710665126691, 8424.157584241526, 12016.819747703617, 12155.453004614637, 12178.330191839534, 12395.008399327851, 12798.744025119631, 11033.393163376091, 11129.16531260175, 11370.488328025423, 11769.52921883115, 11863.584774533196, 10830.458477076272, 10971.0, 11190.0, 11497.94251028773, 11613.245139065933, 10066.647667331608, 10574.365538067741, 10762.677119686421, 10836.187285953427, 11196.104311654884, 9211.907880921373, 9229.400088994194, 9312.534373281173, 9337.346385753204, 9402.059794020817, 8336.291415229773, 8672.349573781865, 8744.213020828156, 8813.603387847434, 9339.346245763003]}, "summary": {"lowerIsBetter": false, "suite": 6759.941190576131, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6996.274491757806, "unit": "ms", "value": 6996.274491757806}, "dojo.html": {"lowerIsBetter": false, "filtered": 5455.33044023806, "unit": "ms", "value": 5455.33044023806}, "mootools.html": {"lowerIsBetter": false, "filtered": 4434.9692593574155, "unit": "ms", "value": 4434.9692593574155}, "ext.html": {"lowerIsBetter": false, "filtered": 18549.896253895306, "unit": "ms", "value": 18549.896253895306}, "prototype.html": {"lowerIsBetter": false, "filtered": 5075.520723617294, "unit": "ms", "value": 5075.520723617294}, "yui.html": {"lowerIsBetter": false, "filtered": 5987.165394214237, "unit": "ms", "value": 5987.165394214237}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-004.e"}, "testrun": {"date": 1447740117, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116203312", "branch": "Fx-Team", "revision": "ffdc7f22130425020f5d648ef99c10b947541659"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 162.0, 161.0, 163.0, 163.0, 165.0, 163.0, 165.0, 170.0, 165.0], "ai-astar": [114.0, 105.0, 113.0, 111.0, 111.0, 126.0, 113.0, 111.0, 114.0, 111.0], "imaging-gaussian-blur": [110.0, 110.0, 109.0, 111.0, 113.0, 110.0, 111.0, 111.0, 110.0, 110.0], "audio-beat-detection": [170.0, 125.0, 153.0, 162.0, 127.0, 155.0, 149.0, 133.0, 165.0, 125.0], "json-stringify-tinderbox": [69.0, 68.0, 69.0, 69.0, 69.0, 71.0, 77.0, 68.0, 70.0, 69.0], "stanford-crypto-pbkdf2": [145.0, 153.0, 151.0, 142.0, 144.0, 153.0, 151.0, 148.0, 158.0, 140.0], "json-parse-financial": [61.0, 61.0, 62.0, 63.0, 63.0, 63.0, 64.0, 66.0, 60.0, 60.0], "stanford-crypto-sha256-iterative": [68.0, 69.0, 69.0, 69.0, 69.0, 65.0, 66.0, 66.0, 69.0, 70.0], "audio-fft": [72.0, 73.0, 71.0, 152.0, 73.0, 72.0, 71.0, 72.0, 156.0, 72.0], "imaging-darkroom": [146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 148.0], "stanford-crypto-ccm": [130.0, 120.0, 121.0, 126.0, 134.0, 124.0, 127.0, 122.0, 120.0, 116.0], "audio-oscillator": [90.0, 90.0, 140.0, 90.0, 91.0, 91.0, 138.0, 90.0, 91.0, 140.0], "stanford-crypto-aes": [86.0, 87.0, 92.0, 86.0, 87.0, 83.0, 85.0, 85.0, 84.0, 84.0], "imaging-desaturate": [96.0, 96.0, 97.0, 95.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1528.5000000000002, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 88.4, "unit": "ms", "value": 88.4}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 148.5, "unit": "ms", "value": 148.5}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 146.4, "unit": "ms", "value": 146.4}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 124.0, "unit": "ms", "value": 124.0}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 146.5, "unit": "ms", "value": 146.5}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 62.3, "unit": "ms", "value": 62.3}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 105.1, "unit": "ms", "value": 105.1}, "ai-astar": {"lowerIsBetter": true, "filtered": 112.9, "unit": "ms", "value": 112.9}, "audio-dft": {"lowerIsBetter": true, "filtered": 163.9, "unit": "ms", "value": 163.9}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 68.0, "unit": "ms", "value": 68.0}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.9, "unit": "ms", "value": 69.9}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 110.5, "unit": "ms", "value": 110.5}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.9, "unit": "ms", "value": 85.9}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.2, "unit": "ms", "value": 96.2}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-004.e"}, "testrun": {"date": 1447740117, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116203312", "branch": "Fx-Team", "revision": "ffdc7f22130425020f5d648ef99c10b947541659"}}, {"talos_counters": {}, "results": {"DeltaBlue": [191.71779141104295], "Encrypt": [280.42624789680315], "NavierStokes": [4840.579710144928], "Decrypt": [5065.656565656565], "Splay": [629.6758104738154], "Richards": [162.73393002441009], "RegExp": [25550.0], "Earley": [720.9805335255949], "Boyer": [12240.963855421687], "RayTrace": [1052.6315789473683]}, "summary": {"lowerIsBetter": false, "suite": 21323.72663438504, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 344.87148800000006, "unit": "score", "value": 344.87148800000006}, "Encrypt": {"lowerIsBetter": false, "filtered": 949.2014460000001, "unit": "score", "value": 949.2014460000001}, "NavierStokes": {"lowerIsBetter": false, "filtered": 306.5748502994012, "unit": "score", "value": 306.5748502994012}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.54619940179463, "unit": "score", "value": 52.54619940179463}, "Splay": {"lowerIsBetter": false, "filtered": 129.41739009900985, "unit": "score", "value": 129.41739009900985}, "RegExp": {"lowerIsBetter": false, "filtered": 35.65499021526421, "unit": "score", "value": 35.65499021526421}, "Richards": {"lowerIsBetter": false, "filtered": 216.93078999999992, "unit": "score", "value": 216.93078999999992}, "Earley": {"lowerIsBetter": false, "filtered": 924.3841810000001, "unit": "score", "value": 924.3841810000001}, "Boyer": {"lowerIsBetter": false, "filtered": 54.4453041338583, "unit": "score", "value": 54.4453041338583}, "RayTrace": {"lowerIsBetter": false, "filtered": 702.9895499999999, "unit": "score", "value": 702.9895499999999}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-004.e"}, "testrun": {"date": 1447740117, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116203312", "branch": "Fx-Team", "revision": "ffdc7f22130425020f5d648ef99c10b947541659"}}] 22:22:07 INFO - RETURN: dromaeo_css: 6759.94 22:22:07 INFO - RETURN: kraken: 1528.50 22:22:07 INFO - RETURN: v8_7: 21323.73 22:22:07 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21323.73"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1528.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6759.94"}}} 22:22:07 INFO - Return code: 0 22:22:07 INFO - # TBPL SUCCESS # 22:22:07 INFO - Running post-action listener: _resource_record_post_action 22:22:07 INFO - Running post-run listener: _resource_record_post_run 22:22:08 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 0; Write bytes: 508211200; Read time: 0; Write time: 519988 22:22:08 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 225005568; Read time: 0; Write time: 288656 22:22:08 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 0; Write bytes: 278237184; Read time: 0; Write time: 187908 22:22:08 INFO - Running post-run listener: _upload_blobber_files 22:22:08 INFO - Blob upload gear active. 22:22:08 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:22:08 INFO - Copying logs to upload dir... 22:22:08 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1268.529625 ========= master_lag: 0.28 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-11-16 22:22:07.917982) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 22:22:07.925543) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1447738109.840296-1726088214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009893 build_url: 'https://queue.taskcluster.net/v1/task/hs4ftGDtSDaQcTG9BKo7kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.46 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 22:22:08.395523) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 22:22:08.395852) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1447738109.840296-1726088214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 22:22:08.412420) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 22:22:08.412729) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 22:22:08.413387) ========= ========= Total master_lag: 0.87 =========