builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-018 starttime: 1447727653.82 results: success (0) buildid: 20151116163023 builduid: badc5e63e5cd460f97669b98ffea3e2c revision: ffe020f9145296f68d56866b01ffe1d35ac18b83 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 18:34:13.817732) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 18:34:13.818227) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 18:34:13.818548) ========= 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=6d5287d839824eebc594b0c9000001d1-1447727653.190162-1838257566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.002903 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 18:34:13.832672) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 18:34:13.832985) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 18:34:13.849811) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:34:13.850226) ========= 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=6d5287d839824eebc594b0c9000001d1-1447727653.190162-1838257566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.035324 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:34:13.899748) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 18:34:13.900199) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 18:34:13.900737) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:34:13.901171) ========= 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=6d5287d839824eebc594b0c9000001d1-1447727653.190162-1838257566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-16 18:34:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.9M=0s 2015-11-16 18:34:14 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.326461 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:34:14.240441) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:34:14.240765) ========= 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=6d5287d839824eebc594b0c9000001d1-1447727653.190162-1838257566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.180235 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:34:14.432568) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-16 18:34:14.432999) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ffe020f9145296f68d56866b01ffe1d35ac18b83 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ffe020f9145296f68d56866b01ffe1d35ac18b83 --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=6d5287d839824eebc594b0c9000001d1-1447727653.190162-1838257566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-16 18:34:14,498 truncating revision to first 12 chars 2015-11-16 18:34:14,498 Setting DEBUG logging. 2015-11-16 18:34:14,498 attempt 1/10 2015-11-16 18:34:14,498 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ffe020f91452?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 18:34:15,811 unpacking tar archive at: mozilla-central-ffe020f91452/testing/mozharness/ program finished with exit code 0 elapsedTime=1.593475 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-16 18:34:16.038798) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 18:34:16.039153) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 18:34:16.049179) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 18:34:16.049518) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 18:34:16.049987) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2015-11-16 18:34:16.050271) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=6d5287d839824eebc594b0c9000001d1-1447727653.190162-1838257566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:34:16 INFO - MultiFileLogger online at 20151116 18:34:16 in /builds/slave/test-pgo 18:34:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:34:16 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:34:16 INFO - {'append_to_log': False, 18:34:16 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:34:16 INFO - 'blob_upload_branch': 'Firefox', 18:34:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:34:16 INFO - 'branch': 'Firefox', 18:34:16 INFO - 'buildbot_json_path': 'buildprops.json', 18:34:16 INFO - 'config_files': ('talos/linux_config.py',), 18:34:16 INFO - 'default_actions': ('clobber', 18:34:16 INFO - 'read-buildbot-config', 18:34:16 INFO - 'download-and-extract', 18:34:16 INFO - 'populate-webroot', 18:34:16 INFO - 'create-virtualenv', 18:34:16 INFO - 'install', 18:34:16 INFO - 'run-tests'), 18:34:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:34:16 INFO - 'download_minidump_stackwalk': True, 18:34:16 INFO - 'download_symbols': 'ondemand', 18:34:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:34:16 INFO - 'tooltool.py': '/tools/tooltool.py', 18:34:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:34:16 INFO - '/tools/misc-python/virtualenv.py')}, 18:34:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:34:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:34:16 INFO - 'installer_path': 'installer.exe', 18:34:16 INFO - 'log_level': 'info', 18:34:16 INFO - 'log_name': 'talos', 18:34:16 INFO - 'log_to_console': True, 18:34:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:34:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:34:16 INFO - 'opt_config_files': (), 18:34:16 INFO - 'pip_index': False, 18:34:16 INFO - 'sps_profile': False, 18:34:16 INFO - 'sps_profile_interval': 0, 18:34:16 INFO - 'suite': 'dromaeojs-e10s', 18:34:16 INFO - 'system_bits': '64', 18:34:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:34:16 INFO - 'title': 'talos-linux64-ix-018', 18:34:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:34:16 INFO - 'use_talos_json': True, 18:34:16 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:34:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:34:16 INFO - 'work_dir': 'build'} 18:34:16 INFO - ##### 18:34:16 INFO - ##### Running clobber step. 18:34:16 INFO - ##### 18:34:16 INFO - Running pre-action listener: _resource_record_pre_action 18:34:16 INFO - Running main action method: clobber 18:34:16 INFO - rmtree: /builds/slave/test-pgo/build 18:34:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:34:17 INFO - Running post-action listener: _resource_record_post_action 18:34:17 INFO - ##### 18:34:17 INFO - ##### Running read-buildbot-config step. 18:34:17 INFO - ##### 18:34:17 INFO - Running pre-action listener: _resource_record_pre_action 18:34:17 INFO - Running main action method: read_buildbot_config 18:34:17 INFO - Using buildbot properties: 18:34:17 INFO - { 18:34:17 INFO - "properties": { 18:34:17 INFO - "buildnumber": 246, 18:34:17 INFO - "product": "firefox", 18:34:17 INFO - "script_repo_revision": "production", 18:34:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:34:17 INFO - "repository": "", 18:34:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 18:34:17 INFO - "buildid": "20151116163023", 18:34:17 INFO - "slavename": "talos-linux64-ix-018", 18:34:17 INFO - "pgo_build": "True", 18:34:17 INFO - "basedir": "/builds/slave/test-pgo", 18:34:17 INFO - "project": "", 18:34:17 INFO - "platform": "ubuntu64_hw", 18:34:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:34:17 INFO - "slavebuilddir": "test", 18:34:17 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 18:34:17 INFO - "branch": "mozilla-central", 18:34:17 INFO - "repo_path": "mozilla-central", 18:34:17 INFO - "stage_platform": "linux64-pgo", 18:34:17 INFO - "builduid": "badc5e63e5cd460f97669b98ffea3e2c", 18:34:17 INFO - "revision": "ffe020f9145296f68d56866b01ffe1d35ac18b83" 18:34:17 INFO - }, 18:34:17 INFO - "sourcestamp": { 18:34:17 INFO - "repository": "", 18:34:17 INFO - "hasPatch": false, 18:34:17 INFO - "project": "", 18:34:17 INFO - "branch": "mozilla-central-linux64-pgo-talos", 18:34:17 INFO - "changes": [ 18:34:17 INFO - { 18:34:17 INFO - "category": null, 18:34:17 INFO - "files": [ 18:34:17 INFO - { 18:34:17 INFO - "url": null, 18:34:17 INFO - "name": "https://queue.taskcluster.net/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 18:34:17 INFO - } 18:34:17 INFO - ], 18:34:17 INFO - "repository": "", 18:34:17 INFO - "rev": "ffe020f9145296f68d56866b01ffe1d35ac18b83", 18:34:17 INFO - "who": "sendchange", 18:34:17 INFO - "when": 1447727405, 18:34:17 INFO - "number": 6669588, 18:34:17 INFO - "comments": "", 18:34:17 INFO - "project": "", 18:34:17 INFO - "at": "Mon 16 Nov 2015 18:30:05", 18:34:17 INFO - "branch": "mozilla-central-linux64-pgo-talos", 18:34:17 INFO - "revlink": "", 18:34:17 INFO - "properties": [ 18:34:17 INFO - [ 18:34:17 INFO - "buildid", 18:34:17 INFO - "20151116163023", 18:34:17 INFO - "Change" 18:34:17 INFO - ], 18:34:17 INFO - [ 18:34:17 INFO - "builduid", 18:34:17 INFO - "badc5e63e5cd460f97669b98ffea3e2c", 18:34:17 INFO - "Change" 18:34:17 INFO - ], 18:34:17 INFO - [ 18:34:17 INFO - "pgo_build", 18:34:17 INFO - "True", 18:34:17 INFO - "Change" 18:34:17 INFO - ] 18:34:17 INFO - ], 18:34:17 INFO - "revision": "ffe020f9145296f68d56866b01ffe1d35ac18b83" 18:34:17 INFO - } 18:34:17 INFO - ], 18:34:17 INFO - "revision": "ffe020f9145296f68d56866b01ffe1d35ac18b83" 18:34:17 INFO - } 18:34:17 INFO - } 18:34:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 18:34:17 INFO - Running post-action listener: _resource_record_post_action 18:34:17 INFO - ##### 18:34:17 INFO - ##### Running download-and-extract step. 18:34:17 INFO - ##### 18:34:17 INFO - Running pre-action listener: _resource_record_pre_action 18:34:17 INFO - Running main action method: download_and_extract 18:34:17 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:34: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')]} 18:34:17 INFO - https://queue.taskcluster.net/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:34:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/test_packages.json 18:34:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/test_packages.json 18:34:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 18:34:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 18:34:18 INFO - Downloaded 1302 bytes. 18:34:18 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 18:34:18 INFO - Using the following test package requirements: 18:34:18 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:34:18 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:34:18 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:34:18 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:34:18 INFO - u'jsshell-linux-x86_64.zip'], 18:34:18 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:34:18 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:34:18 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:34:18 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:34:18 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:34:18 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:34:18 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:34:18 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:34:18 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:34:18 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:34:18 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:34:18 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:34:18 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:34:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:34:18 INFO - https://queue.taskcluster.net/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:34:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:34:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:34:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/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 18:34:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/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 18:34:19 INFO - Downloaded 22461753 bytes. 18:34:19 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 18:34:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:34:19 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 18:34:20 INFO - Return code: 0 18:34:20 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 18:34:20 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')]} 18:34:20 INFO - https://queue.taskcluster.net/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:34:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:34:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:34:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/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 18:34:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/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 18:34:21 INFO - Downloaded 22461753 bytes. 18:34:21 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 18:34:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:34:21 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 18:34:22 INFO - Return code: 0 18:34: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')]} 18:34:22 INFO - https://queue.taskcluster.net/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:34:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:34:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:34:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/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 18:34:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/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 18:34:23 INFO - Downloaded 11131693 bytes. 18:34:23 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 18:34:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:34:23 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 18:34:23 INFO - Return code: 0 18:34: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')]} 18:34:23 INFO - https://queue.taskcluster.net/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:34:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:34:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:34:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/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 18:34:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/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 18:34:25 INFO - Downloaded 57150755 bytes. 18:34:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:34:25 INFO - mkdir: /builds/slave/test-pgo/properties 18:34:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:34:25 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:34:25 INFO - Contents: 18:34:25 INFO - build_url:https://queue.taskcluster.net/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:34:25 INFO - Running post-action listener: _resource_record_post_action 18:34:25 INFO - Running post-action listener: set_extra_try_arguments 18:34:25 INFO - ##### 18:34:25 INFO - ##### Running populate-webroot step. 18:34:25 INFO - ##### 18:34:25 INFO - Running pre-action listener: _resource_record_pre_action 18:34:25 INFO - Running main action method: populate_webroot 18:34:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:34:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:34:25 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:34:25 INFO - '../fennec_ids.txt'], 18:34:25 INFO - 'tests': ['tcheck2']}, 18:34:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:34:25 INFO - '--tppagecycles', 18:34:25 INFO - '7'], 18:34:25 INFO - 'tests': ['tsvgm']}}, 18:34:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:34:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:34:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:34:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:34:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:34:25 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:34:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:34:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:34:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:34:25 INFO - 'talos_options': ['--e10s'], 18:34:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:34:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:34:25 INFO - 'tests': ['damp', 'tps']}, 18:34:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:34:25 INFO - 'talos_options': ['--e10s'], 18:34:25 INFO - 'tests': ['damp', 'tps']}, 18:34:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:34:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:34:25 INFO - 'other': {'tests': ['a11yr', 18:34:25 INFO - 'ts_paint', 18:34:25 INFO - 'tpaint', 18:34:25 INFO - 'sessionrestore', 18:34:25 INFO - 'sessionrestore_no_auto_restore']}, 18:34:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:34:25 INFO - 'tests': ['a11yr', 18:34:25 INFO - 'ts_paint', 18:34:25 INFO - 'tpaint', 18:34:25 INFO - 'sessionrestore', 18:34:25 INFO - 'sessionrestore_no_auto_restore']}, 18:34:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:34:25 INFO - 'tests': ['a11yr', 18:34:25 INFO - 'ts_paint', 18:34:25 INFO - 'tpaint', 18:34:25 INFO - 'sessionrestore', 18:34:25 INFO - 'sessionrestore_no_auto_restore']}, 18:34:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:34:25 INFO - 'tests': ['a11yr', 18:34:25 INFO - 'ts_paint', 18:34:25 INFO - 'tpaint', 18:34:25 INFO - 'sessionrestore', 18:34:25 INFO - 'sessionrestore_no_auto_restore']}, 18:34:25 INFO - 'other_l64': {'tests': ['a11yr', 18:34:25 INFO - 'ts_paint', 18:34:25 INFO - 'tpaint', 18:34:25 INFO - 'sessionrestore', 18:34:25 INFO - 'sessionrestore_no_auto_restore']}, 18:34:25 INFO - 'other_nol64': {'tests': ['a11yr', 18:34:25 INFO - 'ts_paint', 18:34:25 INFO - 'tpaint', 18:34:25 INFO - 'sessionrestore', 18:34:25 INFO - 'sessionrestore_no_auto_restore']}, 18:34:25 INFO - 'svgr': {'tests': ['tsvgx', 18:34:25 INFO - 'tsvgr_opacity', 18:34:25 INFO - 'tart', 18:34:25 INFO - 'tscrollx', 18:34:25 INFO - 'cart']}, 18:34:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:34:25 INFO - 'tests': ['tsvgx', 18:34:25 INFO - 'tsvgr_opacity', 18:34:25 INFO - 'tart', 18:34:25 INFO - 'tscrollx', 18:34:25 INFO - 'cart']}, 18:34:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:34:25 INFO - 'tests': ['tp5o']}, 18:34:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:34:25 INFO - 'talos_options': ['--e10s'], 18:34:25 INFO - 'tests': ['tp5o']}, 18:34:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:34:25 INFO - 'talos_options': ['--xperf_path', 18:34:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:34:25 INFO - 'tests': ['tp5n']}, 18:34:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:34:25 INFO - 'talos_options': ['--e10s', 18:34:25 INFO - '--xperf_path', 18:34:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:34:25 INFO - 'tests': ['tp5n']}}, 18:34:25 INFO - 'talos.zip': {'path': '', 18:34:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:34:25 INFO - Running post-action listener: _resource_record_post_action 18:34:25 INFO - ##### 18:34:25 INFO - ##### Running create-virtualenv step. 18:34:25 INFO - ##### 18:34:25 INFO - Running pre-action listener: _resource_record_pre_action 18:34:25 INFO - Running main action method: create_virtualenv 18:34:25 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:34:25 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 18:34:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:34:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:34:25 INFO - Using real prefix '/usr' 18:34:25 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:34:25 INFO - Installing distribute.............................................................................................................................................................................................done. 18:34:28 INFO - Installing pip.................done. 18:34:28 INFO - Return code: 0 18:34:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:34:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:34:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:34:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:28 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 0x7fb855eb6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb26c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd736e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda9a90>, '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 0xdfbf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfc2e0>, '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': '6d5287d839824eebc594b0c9000001d1-1447727653.190162-1838257566', '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 18:34:28 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 18:34:28 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 18:34:28 INFO - Using env: {'DISPLAY': ':0', 18:34:28 INFO - 'HOME': '/home/cltbld', 18:34:28 INFO - 'LANG': 'en_US.UTF-8', 18:34:28 INFO - 'LANGUAGE': 'en_US:en', 18:34:28 INFO - 'LOGNAME': 'cltbld', 18:34:28 INFO - 'MAIL': '/var/mail/cltbld', 18:34:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:28 INFO - 'MOZ_NO_REMOTE': '1', 18:34:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:34:28 INFO - 'NO_EM_RESTART': '1', 18:34:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:34:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:34:28 INFO - 'PWD': '/builds/slave/test-pgo', 18:34:28 INFO - 'SHELL': '/bin/bash', 18:34:28 INFO - 'SHLVL': '1', 18:34:28 INFO - 'TERM': 'linux', 18:34:28 INFO - 'TMOUT': '86400', 18:34:28 INFO - 'USER': 'cltbld', 18:34:28 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1447727653.190162-1838257566', 18:34:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:28 INFO - '_': '/tools/buildbot/bin/python'} 18:34:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:34:28 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 18:34:28 INFO - Cleaning up... 18:34:28 INFO - Return code: 0 18:34:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:34:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:34:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:34:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:28 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 0x7fb855eb6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb26c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd736e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda9a90>, '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 0xdfbf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfc2e0>, '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': '6d5287d839824eebc594b0c9000001d1-1447727653.190162-1838257566', '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 18:34:28 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 18:34:28 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 18:34:28 INFO - Using env: {'DISPLAY': ':0', 18:34:28 INFO - 'HOME': '/home/cltbld', 18:34:28 INFO - 'LANG': 'en_US.UTF-8', 18:34:28 INFO - 'LANGUAGE': 'en_US:en', 18:34:28 INFO - 'LOGNAME': 'cltbld', 18:34:28 INFO - 'MAIL': '/var/mail/cltbld', 18:34:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:28 INFO - 'MOZ_NO_REMOTE': '1', 18:34:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:34:28 INFO - 'NO_EM_RESTART': '1', 18:34:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:34:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:34:28 INFO - 'PWD': '/builds/slave/test-pgo', 18:34:28 INFO - 'SHELL': '/bin/bash', 18:34:28 INFO - 'SHLVL': '1', 18:34:28 INFO - 'TERM': 'linux', 18:34:28 INFO - 'TMOUT': '86400', 18:34:28 INFO - 'USER': 'cltbld', 18:34:28 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1447727653.190162-1838257566', 18:34:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:28 INFO - '_': '/tools/buildbot/bin/python'} 18:34:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:34:28 INFO - Downloading/unpacking psutil>=0.7.1 18:34:28 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 18:34:28 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 18:34:28 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 18:34:28 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 18:34:28 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 18:34:28 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 18:34:30 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 18:34:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:34:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:34:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:34:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:34:30 INFO - Installing collected packages: psutil 18:34:30 INFO - Running setup.py install for psutil 18:34:30 INFO - building 'psutil._psutil_linux' extension 18:34:30 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 18:34:30 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 18:34:30 INFO - building 'psutil._psutil_posix' extension 18:34:30 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 18:34:31 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 18:34:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:34:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:34:31 INFO - Successfully installed psutil 18:34:31 INFO - Cleaning up... 18:34:31 INFO - Return code: 0 18:34:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:34: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')]} 18:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:34:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34: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')]} 18:34:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:34:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34: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', '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 0x7fb855eb6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb26c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd736e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda9a90>, '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 0xdfbf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfc2e0>, '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': '6d5287d839824eebc594b0c9000001d1-1447727653.190162-1838257566', '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 18:34: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 18:34: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 mozsystemmonitor==0.0.0 18:34:31 INFO - Using env: {'DISPLAY': ':0', 18:34:31 INFO - 'HOME': '/home/cltbld', 18:34:31 INFO - 'LANG': 'en_US.UTF-8', 18:34:31 INFO - 'LANGUAGE': 'en_US:en', 18:34:31 INFO - 'LOGNAME': 'cltbld', 18:34:31 INFO - 'MAIL': '/var/mail/cltbld', 18:34:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:31 INFO - 'MOZ_NO_REMOTE': '1', 18:34:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:34:31 INFO - 'NO_EM_RESTART': '1', 18:34:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:34:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:34:31 INFO - 'PWD': '/builds/slave/test-pgo', 18:34:31 INFO - 'SHELL': '/bin/bash', 18:34:31 INFO - 'SHLVL': '1', 18:34:31 INFO - 'TERM': 'linux', 18:34:31 INFO - 'TMOUT': '86400', 18:34:31 INFO - 'USER': 'cltbld', 18:34:31 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1447727653.190162-1838257566', 18:34:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:31 INFO - '_': '/tools/buildbot/bin/python'} 18:34:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:34:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:34:31 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 18:34:31 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 18:34:31 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 18:34:31 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 18:34:31 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 18:34:31 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 18:34:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:34:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:34:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:34:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:34:33 INFO - Installing collected packages: mozsystemmonitor 18:34:33 INFO - Running setup.py install for mozsystemmonitor 18:34:33 INFO - Successfully installed mozsystemmonitor 18:34:33 INFO - Cleaning up... 18:34:35 INFO - Return code: 0 18:34:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:34: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')]} 18:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:34:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34: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')]} 18:34:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:34:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:35 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 0x7fb855eb6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb26c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd736e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda9a90>, '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 0xdfbf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfc2e0>, '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': '6d5287d839824eebc594b0c9000001d1-1447727653.190162-1838257566', '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 18:34:35 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 18:34:35 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 18:34:35 INFO - Using env: {'DISPLAY': ':0', 18:34:35 INFO - 'HOME': '/home/cltbld', 18:34:35 INFO - 'LANG': 'en_US.UTF-8', 18:34:35 INFO - 'LANGUAGE': 'en_US:en', 18:34:35 INFO - 'LOGNAME': 'cltbld', 18:34:35 INFO - 'MAIL': '/var/mail/cltbld', 18:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:35 INFO - 'MOZ_NO_REMOTE': '1', 18:34:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:34:35 INFO - 'NO_EM_RESTART': '1', 18:34:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:34:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:34:35 INFO - 'PWD': '/builds/slave/test-pgo', 18:34:35 INFO - 'SHELL': '/bin/bash', 18:34:35 INFO - 'SHLVL': '1', 18:34:35 INFO - 'TERM': 'linux', 18:34:35 INFO - 'TMOUT': '86400', 18:34:35 INFO - 'USER': 'cltbld', 18:34:35 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1447727653.190162-1838257566', 18:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:35 INFO - '_': '/tools/buildbot/bin/python'} 18:34:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:34:35 INFO - Downloading/unpacking blobuploader==1.2.4 18:34:35 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 18:34:35 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 18:34:35 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 18:34:35 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 18:34:35 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 18:34:35 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 18:34:37 INFO - Downloading blobuploader-1.2.4.tar.gz 18:34:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:34:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:34:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:34:37 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 18:34:37 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 18:34:37 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 18:34:37 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 18:34:37 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 18:34:37 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 18:34:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:34:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:34:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:34:37 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 18:34:37 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 18:34:37 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 18:34:37 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 18:34:37 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 18:34:37 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 18:34:37 INFO - Downloading docopt-0.6.1.tar.gz 18:34:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:34:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:34:37 INFO - Installing collected packages: blobuploader, requests, docopt 18:34:37 INFO - Running setup.py install for blobuploader 18:34:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:34:37 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:34:37 INFO - Running setup.py install for requests 18:34:38 INFO - Running setup.py install for docopt 18:34:38 INFO - Successfully installed blobuploader requests docopt 18:34:38 INFO - Cleaning up... 18:34:38 INFO - Return code: 0 18:34:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:34: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')]} 18:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:34:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34: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')]} 18:34:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:34:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:38 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 0x7fb855eb6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb26c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd736e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda9a90>, '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 0xdfbf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfc2e0>, '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': '6d5287d839824eebc594b0c9000001d1-1447727653.190162-1838257566', '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 18:34:38 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 18:34:38 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 18:34:38 INFO - Using env: {'DISPLAY': ':0', 18:34:38 INFO - 'HOME': '/home/cltbld', 18:34:38 INFO - 'LANG': 'en_US.UTF-8', 18:34:38 INFO - 'LANGUAGE': 'en_US:en', 18:34:38 INFO - 'LOGNAME': 'cltbld', 18:34:38 INFO - 'MAIL': '/var/mail/cltbld', 18:34:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:38 INFO - 'MOZ_NO_REMOTE': '1', 18:34:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:34:38 INFO - 'NO_EM_RESTART': '1', 18:34:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:34:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:34:38 INFO - 'PWD': '/builds/slave/test-pgo', 18:34:38 INFO - 'SHELL': '/bin/bash', 18:34:38 INFO - 'SHLVL': '1', 18:34:38 INFO - 'TERM': 'linux', 18:34:38 INFO - 'TMOUT': '86400', 18:34:38 INFO - 'USER': 'cltbld', 18:34:38 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1447727653.190162-1838257566', 18:34:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:38 INFO - '_': '/tools/buildbot/bin/python'} 18:34:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:34:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:34:38 INFO - Running setup.py (path:/tmp/pip-hl0Bpq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:34:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:34:38 INFO - Running setup.py (path:/tmp/pip-lTrqrY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:34:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:34:38 INFO - Running setup.py (path:/tmp/pip-XpRGoa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:34:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:34:38 INFO - Running setup.py (path:/tmp/pip-9VH82P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:34:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:34:38 INFO - Running setup.py (path:/tmp/pip-xdGTSb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:34:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:34:38 INFO - Running setup.py (path:/tmp/pip-yf1vTb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:34:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:34:39 INFO - Running setup.py (path:/tmp/pip-nDNPKo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:34:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:34:39 INFO - Running setup.py (path:/tmp/pip-txRwqD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:34:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:34:39 INFO - Running setup.py (path:/tmp/pip-TyQS9i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:34:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:34:39 INFO - Running setup.py (path:/tmp/pip-A477W0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:34:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:34:39 INFO - Running setup.py (path:/tmp/pip-hRS7h_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:34:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:34:39 INFO - Running setup.py (path:/tmp/pip-W0uNzb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:34:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:34:39 INFO - Running setup.py (path:/tmp/pip-e7cugy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:34:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:34:39 INFO - Running setup.py (path:/tmp/pip-j5BkVh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:34:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:34:39 INFO - Running setup.py (path:/tmp/pip-hPGIMf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:34:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:34:39 INFO - Running setup.py (path:/tmp/pip-PS4QNx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:34:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:34:39 INFO - Running setup.py (path:/tmp/pip-dvpxal-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:34:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:34:39 INFO - Running setup.py install for manifestparser 18:34:39 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:34:39 INFO - Running setup.py install for mozcrash 18:34:39 INFO - Running setup.py install for mozdebug 18:34:40 INFO - Running setup.py install for mozdevice 18:34:40 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:34:40 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:34:40 INFO - Running setup.py install for mozfile 18:34:40 INFO - Running setup.py install for mozhttpd 18:34:40 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:34:40 INFO - Running setup.py install for mozinfo 18:34:40 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:34:40 INFO - Running setup.py install for mozInstall 18:34:40 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:34:40 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:34:40 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:34:40 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:34:40 INFO - Running setup.py install for mozleak 18:34:40 INFO - Running setup.py install for mozlog 18:34:40 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:34:40 INFO - Running setup.py install for moznetwork 18:34:40 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:34:40 INFO - Running setup.py install for mozprocess 18:34:41 INFO - Running setup.py install for mozprofile 18:34:41 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:34:41 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:34:41 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:34:41 INFO - Running setup.py install for mozrunner 18:34:41 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:34:41 INFO - Running setup.py install for mozscreenshot 18:34:41 INFO - Running setup.py install for moztest 18:34:41 INFO - Running setup.py install for mozversion 18:34:41 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:34:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:34:41 INFO - Cleaning up... 18:34:41 INFO - Return code: 0 18:34:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:34:41 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')]} 18:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:34:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:41 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')]} 18:34:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:34:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:41 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 0x7fb855eb6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb26c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd736e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda9a90>, '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 0xdfbf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfc2e0>, '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': '6d5287d839824eebc594b0c9000001d1-1447727653.190162-1838257566', '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 18:34:41 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 18:34:41 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 18:34:41 INFO - Using env: {'DISPLAY': ':0', 18:34:41 INFO - 'HOME': '/home/cltbld', 18:34:41 INFO - 'LANG': 'en_US.UTF-8', 18:34:41 INFO - 'LANGUAGE': 'en_US:en', 18:34:41 INFO - 'LOGNAME': 'cltbld', 18:34:41 INFO - 'MAIL': '/var/mail/cltbld', 18:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:41 INFO - 'MOZ_NO_REMOTE': '1', 18:34:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:34:41 INFO - 'NO_EM_RESTART': '1', 18:34:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:34:41 INFO - 'PWD': '/builds/slave/test-pgo', 18:34:41 INFO - 'SHELL': '/bin/bash', 18:34:41 INFO - 'SHLVL': '1', 18:34:41 INFO - 'TERM': 'linux', 18:34:41 INFO - 'TMOUT': '86400', 18:34:41 INFO - 'USER': 'cltbld', 18:34:41 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1447727653.190162-1838257566', 18:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:41 INFO - '_': '/tools/buildbot/bin/python'} 18:34:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:34:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:34:41 INFO - Running setup.py (path:/tmp/pip-QGfdlu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:34:41 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)) 18:34:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:34:41 INFO - Running setup.py (path:/tmp/pip-s7bZmc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:34:41 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)) 18:34:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:34:41 INFO - Running setup.py (path:/tmp/pip-DwMvFq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:34:41 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)) 18:34:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:34:42 INFO - Running setup.py (path:/tmp/pip-w5eCjZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:34:42 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)) 18:34:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:34:42 INFO - Running setup.py (path:/tmp/pip-aHWZB5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:34:42 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)) 18:34:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:34:42 INFO - Running setup.py (path:/tmp/pip-ShNmlI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:34:42 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)) 18:34:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:34:42 INFO - Running setup.py (path:/tmp/pip-zyyZAM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:34:42 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)) 18:34:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:34:42 INFO - Running setup.py (path:/tmp/pip-b2NbcN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:34:42 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)) 18:34:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:34:42 INFO - Running setup.py (path:/tmp/pip-iFFn8F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:34:42 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)) 18:34:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:34:42 INFO - Running setup.py (path:/tmp/pip-ihGkEx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:34:42 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)) 18:34:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:34:42 INFO - Running setup.py (path:/tmp/pip-n3CWfo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:34:42 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)) 18:34:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:34:42 INFO - Running setup.py (path:/tmp/pip-coI9Ob-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:34:42 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)) 18:34:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:34:42 INFO - Running setup.py (path:/tmp/pip-WJ6y9f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:34:42 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)) 18:34:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:34:42 INFO - Running setup.py (path:/tmp/pip-VMxPdt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:34:42 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)) 18:34:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:34:42 INFO - Running setup.py (path:/tmp/pip-Q5qpRZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:34:42 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)) 18:34:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:34:42 INFO - Running setup.py (path:/tmp/pip-jdgRG8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:34:42 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)) 18:34:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:34:42 INFO - Running setup.py (path:/tmp/pip-Njkgrq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:34:43 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)) 18:34:43 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)) 18:34:43 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)) 18:34:43 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)) 18:34:43 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)) 18:34:43 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)) 18:34:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:34:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:34:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:34:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:34:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:34:44 INFO - Downloading blessings-1.5.1.tar.gz 18:34:44 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 18:34:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:34:44 INFO - Installing collected packages: blessings 18:34:44 INFO - Running setup.py install for blessings 18:34:44 INFO - Successfully installed blessings 18:34:44 INFO - Cleaning up... 18:34:44 INFO - Return code: 0 18:34:44 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:34:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:34:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:34:45 INFO - Reading from file tmpfile_stdout 18:34:45 INFO - Current package versions: 18:34:45 INFO - argparse == 1.2.1 18:34:45 INFO - blessings == 1.5.1 18:34:45 INFO - blobuploader == 1.2.4 18:34:45 INFO - docopt == 0.6.1 18:34:45 INFO - manifestparser == 1.1 18:34:45 INFO - mozInstall == 1.12 18:34:45 INFO - mozcrash == 0.16 18:34:45 INFO - mozdebug == 0.1 18:34:45 INFO - mozdevice == 0.47 18:34:45 INFO - mozfile == 1.2 18:34:45 INFO - mozhttpd == 0.7 18:34:45 INFO - mozinfo == 0.9 18:34:45 INFO - mozleak == 0.1 18:34:45 INFO - mozlog == 3.0 18:34:45 INFO - moznetwork == 0.27 18:34:45 INFO - mozprocess == 0.22 18:34:45 INFO - mozprofile == 0.27 18:34:45 INFO - mozrunner == 6.11 18:34:45 INFO - mozscreenshot == 0.1 18:34:45 INFO - mozsystemmonitor == 0.0 18:34:45 INFO - moztest == 0.7 18:34:45 INFO - mozversion == 1.4 18:34:45 INFO - psutil == 3.1.1 18:34:45 INFO - requests == 1.2.3 18:34:45 INFO - wsgiref == 0.1.2 18:34:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:34:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:34:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:34:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fb855eb6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb26c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd736e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda9a90>, '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 0xdfbf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfc2e0>, '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': '6d5287d839824eebc594b0c9000001d1-1447727653.190162-1838257566', '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 18:34:45 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 18:34:45 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 18:34:45 INFO - Using env: {'DISPLAY': ':0', 18:34:45 INFO - 'HOME': '/home/cltbld', 18:34:45 INFO - 'LANG': 'en_US.UTF-8', 18:34:45 INFO - 'LANGUAGE': 'en_US:en', 18:34:45 INFO - 'LOGNAME': 'cltbld', 18:34:45 INFO - 'MAIL': '/var/mail/cltbld', 18:34:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:45 INFO - 'MOZ_NO_REMOTE': '1', 18:34:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:34:45 INFO - 'NO_EM_RESTART': '1', 18:34:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:34:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:34:45 INFO - 'PWD': '/builds/slave/test-pgo', 18:34:45 INFO - 'SHELL': '/bin/bash', 18:34:45 INFO - 'SHLVL': '1', 18:34:45 INFO - 'TERM': 'linux', 18:34:45 INFO - 'TMOUT': '86400', 18:34:45 INFO - 'USER': 'cltbld', 18:34:45 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1447727653.190162-1838257566', 18:34:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:45 INFO - '_': '/tools/buildbot/bin/python'} 18:34:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:34:45 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)) 18:34:45 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)) 18:34:45 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)) 18:34:45 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)) 18:34:45 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)) 18:34:45 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)) 18:34:45 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)) 18:34:45 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)) 18:34:45 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)) 18:34:45 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)) 18:34:45 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)) 18:34:45 INFO - Cleaning up... 18:34:45 INFO - Return code: 0 18:34:45 INFO - Running post-action listener: _resource_record_post_action 18:34:45 INFO - Running post-action listener: _start_resource_monitoring 18:34:45 INFO - Starting resource monitoring. 18:34:45 INFO - ##### 18:34:45 INFO - ##### Running install step. 18:34:45 INFO - ##### 18:34:45 INFO - Running pre-action listener: _resource_record_pre_action 18:34:45 INFO - Running main action method: install 18:34:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:34:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:34:45 INFO - Reading from file tmpfile_stdout 18:34:45 INFO - Detecting whether we're running mozinstall >=1.0... 18:34:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:34:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:34:45 INFO - Reading from file tmpfile_stdout 18:34:45 INFO - Output received: 18:34:45 INFO - Usage: mozinstall [options] installer 18:34:45 INFO - Options: 18:34:45 INFO - -h, --help show this help message and exit 18:34:45 INFO - -d DEST, --destination=DEST 18:34:45 INFO - Directory to install application into. [default: 18:34:45 INFO - "/builds/slave/test-pgo"] 18:34:45 INFO - --app=APP Application being installed. [default: firefox] 18:34:45 INFO - mkdir: /builds/slave/test-pgo/build/application 18:34:45 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'] 18:34:45 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 18:35:00 INFO - Reading from file tmpfile_stdout 18:35:00 INFO - Output received: 18:35:00 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:35:00 INFO - Running post-action listener: _resource_record_post_action 18:35:00 INFO - ##### 18:35:00 INFO - ##### Running run-tests step. 18:35:00 INFO - ##### 18:35:00 INFO - Running pre-action listener: _resource_record_pre_action 18:35:00 INFO - Running main action method: run_tests 18:35:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:35:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:35:00 INFO - Python 2.7.3 18:35:00 INFO - Return code: 0 18:35:00 INFO - grabbing minidump binary from tooltool 18:35: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')]} 18:35:00 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 0xda9a90>, '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 0xdfbf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfc2e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:35:00 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 18:35:00 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 18:35:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:35:00 INFO - Return code: 0 18:35:00 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:35:00 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:35:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:35:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:35:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:35:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 18:35:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost 18:35:00 INFO - Using env: {'DISPLAY': ':0', 18:35:00 INFO - 'HOME': '/home/cltbld', 18:35:00 INFO - 'LANG': 'en_US.UTF-8', 18:35:00 INFO - 'LANGUAGE': 'en_US:en', 18:35:00 INFO - 'LOGNAME': 'cltbld', 18:35:00 INFO - 'MAIL': '/var/mail/cltbld', 18:35:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:35:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:35:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:00 INFO - 'MOZ_NO_REMOTE': '1', 18:35:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:35:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:35:00 INFO - 'NO_EM_RESTART': '1', 18:35:00 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:35:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:35:00 INFO - 'PWD': '/builds/slave/test-pgo', 18:35:00 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:35:00 INFO - 'SHELL': '/bin/bash', 18:35:00 INFO - 'SHLVL': '1', 18:35:00 INFO - 'TERM': 'linux', 18:35:00 INFO - 'TMOUT': '86400', 18:35:00 INFO - 'USER': 'cltbld', 18:35:00 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1447727653.190162-1838257566', 18:35:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:00 INFO - '_': '/tools/buildbot/bin/python'} 18:35:00 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost'] with output_timeout 3600 18:35:00 INFO - mozversion INFO | application_buildid: 20151116163023 18:35:00 INFO - mozversion INFO | application_changeset: ffe020f9145296f68d56866b01ffe1d35ac18b83 18:35:00 INFO - mozversion INFO | application_display_name: Nightly 18:35:00 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:35:00 INFO - mozversion INFO | application_name: Firefox 18:35:00 INFO - mozversion INFO | application_remotingname: firefox 18:35:00 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 18:35:00 INFO - mozversion INFO | application_vendor: Mozilla 18:35:00 INFO - mozversion INFO | application_version: 45.0a1 18:35:00 INFO - mozversion INFO | platform_buildid: 20151116163023 18:35:00 INFO - mozversion INFO | platform_changeset: ffe020f9145296f68d56866b01ffe1d35ac18b83 18:35:00 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 18:35:00 INFO - mozversion INFO | platform_version: 45.0a1 18:35:00 INFO - 2015-11-16 18:35:00,275 DEBUG : using testdate: 1447727700 18:35:00 INFO - 2015-11-16 18:35:00,275 DEBUG : actual date: 1447727700 18:35:00 INFO - 2015-11-16 18:35:00,283 INFO : starting webserver on 'localhost:36005' 18:35:00 INFO - 2015-11-16 18:35:00,284 INFO : Starting test suite talos-linux64-ix-018.e 18:35:00 INFO - 2015-11-16 18:35:00,285 INFO : Starting test dromaeo_css 18:35:00 INFO - 2015-11-16 18:35:00,285 DEBUG : operating with platform_type : linux_ 18:35:00 INFO - 2015-11-16 18:35:00,285 INFO : Initialising browser for dromaeo_css test... 18:35:00 INFO - 2015-11-16 18:35:00,302 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpesF3lu/profile http://localhost:36005/getInfo.html 18:35:04 INFO - 2015-11-16 18:35:04,913 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:35:04 INFO - 2015-11-16 18:35:04,913 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:35:04 INFO - 2015-11-16 18:35:04,914 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:35:04 INFO - 2015-11-16 18:35:04,914 DEBUG : BROWSER_OUTPUT: __metrics 18:35:06 INFO - 2015-11-16 18:35:06,318 INFO : Browser initialized. 18:35:06 INFO - 2015-11-16 18:35:06,319 INFO : Running cycle 1/1 for dromaeo_css test... 18:35:06 INFO - 2015-11-16 18:35:06,319 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpesF3lu/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:35:18 INFO - 2015-11-16 18:35:18,081 DEBUG : BROWSER_OUTPUT: RSS: Main: 141209600 18:35:18 INFO - 2015-11-16 18:35:18,081 DEBUG : BROWSER_OUTPUT: 18:36:07 INFO - 2015-11-16 18:36:07,713 DEBUG : BROWSER_OUTPUT: 1447727767709 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] 18:38:16 INFO - 2015-11-16 18:38:16,615 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36005/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36005/tests/dromaeo/cssquery-ext.html) 18:38:17 INFO - 2015-11-16 18:38:17,727 DEBUG : BROWSER_OUTPUT: RSS: Main: 145268736 18:38:17 INFO - 2015-11-16 18:38:17,727 DEBUG : BROWSER_OUTPUT: 18:41:19 INFO - 2015-11-16 18:41:19,645 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36005/tests/dromaeo/cssquery-ext.html (next: http://localhost:36005/tests/dromaeo/cssquery-jquery.html) 18:41:20 INFO - 2015-11-16 18:41:20,231 DEBUG : BROWSER_OUTPUT: RSS: Main: 141553664 18:41:20 INFO - 2015-11-16 18:41:20,231 DEBUG : BROWSER_OUTPUT: 18:44:21 INFO - 2015-11-16 18:44:21,855 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36005/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36005/tests/dromaeo/cssquery-mootools.html) 18:44:22 INFO - 2015-11-16 18:44:22,430 DEBUG : BROWSER_OUTPUT: RSS: Main: 143441920 18:44:22 INFO - 2015-11-16 18:44:22,430 DEBUG : BROWSER_OUTPUT: 18:47:24 INFO - 2015-11-16 18:47:24,056 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36005/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36005/tests/dromaeo/cssquery-prototype.html) 18:47:24 INFO - 2015-11-16 18:47:24,644 DEBUG : BROWSER_OUTPUT: RSS: Main: 140599296 18:47:24 INFO - 2015-11-16 18:47:24,645 DEBUG : BROWSER_OUTPUT: 18:50:26 INFO - 2015-11-16 18:50:26,944 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36005/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36005/tests/dromaeo/cssquery-yui.html) 18:50:27 INFO - 2015-11-16 18:50:27,546 DEBUG : BROWSER_OUTPUT: RSS: Main: 140128256 18:50:27 INFO - 2015-11-16 18:50:27,546 DEBUG : BROWSER_OUTPUT: 18:53:29 INFO - 2015-11-16 18:53:29,744 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36005/tests/dromaeo/cssquery-yui.html (next: http://localhost:36005/tests/dromaeo/cssquery-dojo.html) 18:53:30 INFO - 2015-11-16 18:53:30,003 DEBUG : BROWSER_OUTPUT: RSS: Main: 143781888 18:53:30 INFO - 2015-11-16 18:53:30,003 DEBUG : BROWSER_OUTPUT: 18:53:30 INFO - 2015-11-16 18:53:30,003 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:53:30 INFO - 2015-11-16 18:53:30,003 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:53:30 INFO - 2015-11-16 18:53:30,003 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:53:30 INFO - 2015-11-16 18:53:30,003 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:53:30 INFO - 2015-11-16 18:53:30,003 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3275.6560561141064;3298.9340213195733;3310.222097807016;3313.90058298251;3350.296437748073;5469.234307196985;5644.153376993448;5650.29371328584;5687.601867869251;5688.800891968782;5495.148252020943;5530.751116199771;5560.193771903072;5560.7219639017985;5618.494335509803;5056.342675452195;5096.210087436453;5185.170372740362;5185.2999845021;5232.764525596357;5167.431582525919;5168.250603662466;5216.374035115772;5228.633995620289;5238.633295669305;5009.674371165863;5038.496150384969;5109.974450127745;5166.560842328407;5185.662931909414;5172.094883395391;5180.507851754077;5190.299309593194;5197.298364720752;5236.083685355085;4997.450280469146;5162.561182299509;5164.535191832715;5166.225066240057;5167.4057483389515;5302.893942121174;5420.972895135538;5452.482014208644;5455.563554915637;5464.836054918359;6077.058056001327;6113.083037544359;6135.079738039285;6135.233095863017;6164.013757798775;6094.39056094387;6157.815265542041;6161.260648722137;6161.876762464725;6177.104319873638;5644.943550564483;5707.200991861143;5751.223584816038;5763.94236057634;5817.389174136655;6204.13142160098;6224.128621992924;6248.843778905563;6271.498280137578;6281.842953926189;6044.153818465418;6047.2743270806905;6051.425114614105;6060.757295217397;6105.9694701526205;5954;6003.429674180946;6068.575199735976;6068.696565171812;6120.051392034242;6047.0324748040985;6153.876922461615;6164.907526387108;6165.0444181152;6165.506759459233;5922.970385148133;6077;6131.233595800525;6131.356207598227;6132.17215675878;4581.496035436099;4631.768411579407;4653.069386122789;4654.883627909329;4675.158471475167;4128.793560321972;4132.607402296777;4135.276326642826;4141.275276826544;4169.60388763067;5830.82507524775;5847.912281315784;5848.912266316009;5849.473547380756;5893.469587737124;5943.673097979567;6021.397860213943;6076.240469941257;6104.732011601605;6108.493847774667;5833.095870140135;5925.40745925404;5927;5944.851378715567;5947.434993675594;5109.054824857339;5359.946400536022;5364.436734142937;5379.54273886724;5385.030694474954;6257;6263.060540918898;6472.255690595548;6475.935240647627;6490.707918143695;6118.60229085108;6126.479249263684;6148.723307451265;6152.107944347955;6159.5072394209255;6132.661461321697;6224.657643829632;6392.137061496638;6396.872062558816;6419.935800641933;5910.379410161871;5927.762889484372;5958.702064896651;5975.641461512323;5995.790147344822;6056.152138700498;6060.757569697339;6105.358937311518;6131.417515336036;6172.814815555541;5825.94174058254;5833.066709326487;5917.497012753965;5920.970395148169;5958.7616495341435;5956.404359564009;5958.255218097738;5968;5977;5978.372270911492;5802.332731735904;5810.854728631818;5832.445917637818;5834.445727655866;5846.41535846429;5771.192033115283;5941.287045554561;5947.613405128653;5977.880442391215;6120.60216085953;5839.824805255849;5861.7655293787775;5880.705964701662;5893.852653683521;5900.085486749561 18:53:30 INFO - 2015-11-16 18:53:30,004 DEBUG : BROWSER_OUTPUT: |1;ext.html;559.7509108446743;596.5585466754601;603.2700432476704;607.0772425912613;608.4858294740948;39218.60781392185;40574.39138412926;40729.18541629169;40731.79634101826;40869.59130408695;43368;44232.33651495222;44342.556574434246;44368;44376.556234437645;8921.866172007425;9000.324975626821;9080.636774529012;9082.273418126568;9086.545672716371;8606.225439710424;8689.826203475926;8714.869276960851;8742.912570874274;8745.606447709837;8817.470951742916;8874.467531948072;8896.733098007038;8928.062553431893;8950.41822281553;8850.380473366868;8921.509316987564;8940.821183576358;8944.776380590472;8958.507282099481;8825.602847871862;8944.060873608243;8950.060243674385;8950.507722075283;8959.5968181432;40715.59284407148;40841.18317633631;41106.38340424896;41209.175816483505;41293.58706412927;3403.710684591813;3444.844981975817;3456.1705190754287;3565.750397472178;3824.674902633252;30335;30564.541531876817;30788.8460557698;30794.230144246572;30915.845420772977;3415.692587667097;3490.3891818931584;3575.8390872410805;3627.8004709740953;3628.981855090734;262541;263470.68264658743;263933;264050;265286;61433.38566614366;61583.38416615777;61812.69093654503;62105;62167.37832621706;60493.69753151206;63234.36765632285;64583.354166458674;67673.6616316925;67796.32203677998;15158.498847690229;15174.393024278905;15196.088234705952;15252;15415.768763468557;11628.709282268012;11643.53425862956;11671.824922626167;11682.948534631754;11728.824067638992;20502.38492845217;20964.79035209659;21085.89457052705;21093.472663183544;21094;7602.50583712057;7788.844223115506;7790.766277011699;7814.882776758353;7841.784523398882;1022.5807418958192;1054.372648274291;1068.471106802138;1071.1751950997689;1088;28331.858340708575;28927.85536072306;29363.55954660682;29465.410691786044;29489.557656635166;1003.8745156855393;1008.6671398438498;1026.5329275179774;1039.8336266197373;1124.1400328748514;13584.117032392864;13683.657908552366;13991.720165596631;14022.649433764238;14032.508862189978;315963;319785;323030;324673;324852;53617.46382536203;53772.73113634407;53797.1930421044;53809.46190538123;54089.72955135199;1371.0882263294995;1380.0477670407588;1388.590365842079;1393.1571399303275;1394.135635905745;25747.227583172535;26696.733032669425;26752.8662356687;26953.59569606418;27186;45705.085898282516;45738.77130614326;45788.08423831438;45902.31146532738;45918.770406149095;295565;298118;299452;299549;300144;32004.5199322015;32448.51327230046;32563.18592035218;32720.181995450304;32739.34521309513;40127.39808902927;43475;43901.78049109734;44644.33033504435;44950;33781;33831.49252761161;33875.49186762151;34065.82967085149;34784.82607586946;33939.830300848334;34463.65536344604;34705.479417809256;36679.449808252364;36879;36293.63706362902;36388.81805591061;36516.087097821706;36637.63362366342;36653;28749.28126796847;29138.417231654825;30799.384012320075;30836.84581577078;31049.223769405944;24866.856004831963;25204.621930671423;25253;25319.36701582475;25320 18:53:30 INFO - 2015-11-16 18:53:30,004 DEBUG : BROWSER_OUTPUT: |2;jquery.html;346.77806204029423;350.2801742419328;352.9823508824558;354.1518064236154;354.925465652213;12522.436490357934;12946.223226606411;16460.753088703663;17282.65434691307;18570.53573660659;10873.075788557962;10905.563777448913;11273.154513411506;11852.585159519418;12063.215890967082;4588.4493860736675;4680.227762419197;4693.7653117344;4695.976520117395;4704.435467743859;4867.756612169377;4973.651844370896;4978.825741099062;5006.07387633289;5008;3489.616142224353;3568.7858728476244;4757.333973243749;4958.181899986516;4958.231474121517;6582.934170658304;6739.989001649743;6755.898661520106;6775.661216939158;6784.423324017464;6338.461230795388;6472.838179045514;6484.416402523795;6514.153160089206;6524.217093948757;21005.789942100688;22081;22883;23268.53462930732;23501.059957601676;2126.6278401279715;2234.452559123009;2261.09960318451;2267.319804058776;2284.4174735442357;14177.220252886087;14267.500637477639;14436.422543098264;14549.927250363786;14944;1951.7657881054222;1974.5162435203467;1981.8414526837819;2008.457716416574;2065.648839697255;65842.67078664576;69044.6547767263;69126;69415.65292173506;69920;15101;15916.204189790697;15953.760693589606;16019.199040047952;16039.839601604068;24135.517289654108;24149.879250603986;24495;24554.631680524806;24642.260732178063;9311.813763724824;9327.626894924262;9373.718788436357;9457.479838608804;9479.857802132974;8004.119546849842;8004.879926801103;8008.919910800817;8050.959745201237;8061.6372263248295;7682.846343073107;7696.307332340116;7746.922530774733;7749.147593764681;7750.7674769756995;3214.51782232667;3259.3155437357946;3259.755518336134;3278.7868788528667;3315.8839440619463;389.8869327894935;397.45747055269925;399.92201520703185;400.65943947644854;502.8466317773114;9897.703068907944;10070.59717611302;10225.744356391;10607.310524815863;10880.455977201109;400.37941191153595;427.18194657231675;436.73795722566206;437.6783064447628;439.51872699394113;5861.20873682056;5923.851903702442;5962.85092872673;5964.254468191476;6019.819405417845;514333;521390;533550;534589;544865;77886.22113778903;78059.60970195112;78451.2154878444;80129;81388.18611813807;456.80129143822546;457.32544496866853;457.4373520569718;459.38213103375904;462.4797103258834;9890.752731181778;10055.849162262426;10075.697729068139;10079.949600252245;10184.847227291448;33455.66544334526;33845.153871153416;34027.65972340245;34694.30611387808;35212.29575408426;46745;46787.35109983881;47429.28856067231;47443.76278118588;48083.519164807905;6835.179778426621;6859.279775623488;6886.001529778054;6922.10012698346;6927.445804335742;12097.879021209676;12466.43901024438;12616.74766504683;12626.873731262569;12721.618351449471;10872.402017889091;10946.233763636468;11066.225364224427;11147.72130696739;11173.888261117285;10469.424181670081;10844.566217351534;11017.283876548;11057.447127643747;11066.391348475589;10715.303505272132;10766.300190487593;10853.077488413257;11138.832917506406;11169.162312826407;6514.9348506514325;6970.860582788418;7035.050268213726;7037.366637002694;7052.259512751088;10898.78202435931;11152.107831373633;11156.888431115909;11210.551577937118;11294.435278235891 18:53:30 INFO - 2015-11-16 18:53:30,004 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1513.9243037848105;1682.2429906542056;1728.6542691461702;1732.0122788190365;1762.4360204734483;7546.1321947976;7690.5770182639935;7765.495242809214;7783.1438541760435;7906.130325664172;7787.883181752279;7800.453968222212;7817.804554886116;7887.645055972481;7895.447318687694;2112.2923820520105;2129;2138.187488754279;2142.592907347607;2166.967495487569;2208.447888027993;2248.4041728941843;2272.318304508649;2272.761360057195;2283.292179424384;2217.1796435318956;2233.039792889057;2257.164849005862;2264.0264686184933;2269.523400085984;2222.9666555001686;2224.9110035598555;2239.4961133745023;2252.0653928619604;2252.977470225293;2288.7482376938524;2305.6080466320764;2311.8266130040315;2315.8378913476063;2322.2800931711054;7675.5010924289745;7722.922770772277;7736.265054819839;7743.303102720783;7752.496087754278;4452.866414007585;4457.799399027052;4465.218586747306;4489.102179564067;4499.6400287976885;2984.328526081636;2984.820910745362;3089.8609562569736;3102.2089367211443;3108.4404807134706;1011.519528224095;1023.7542989682497;1027.8047171037479;1030.8402197659375;1047.8323468245044;10480.371177729285;10502.789944201073;10508.2644214905;10524.105451036594;10579.682609521727;3977.3238549446664;3979.9403008954887;4025.355943049098;4035.394690796404;4129.91740165195;8651.6971905983;8673.783155421164;8685.696000639948;8699.478031318142;8705.12948705137;4557.453105627346;4566.56617621332;4569.657275704269;4579.908401832011;4603.033362993809;4179.749215047107;4200.558941311179;4203;4234.618884300427;4241.1941731071;3416.9658303417145;3423.8972830815114;3433.4678124890684;3434.433318502469;3448.4654878493875;1060.4379678770265;1074.274864466482;1077.9946100269449;1092.7377429417043;1103.3710784852717;1067.8505009298703;1078.9406582637873;1149.9995004346272;1238.5107882386408;1335.8129861819352;6927.445804335641;7002.264762199896;7010.298970102949;7030;7093.680784364716;1133.880942501042;1144.5192073034145;1154.3362566524281;1157.2767020612118;1160.4313886195703;5713.771449141987;5762.2221000164445;5764.827055188351;5793.131030345482;5806;9039.18647321731;9053.411528250643;9158.86261706075;9304.813903721888;9336.766580835534;9009.774755631162;9120.680776172801;9140.268778497704;9148.359614827032;9153.862692059625;7144.535605185646;7202.53183543068;7240.348368646953;7294.307040831112;7310.597917114504;7093.964530177316;7148.857022859618;7150.499465037606;7202.675879585327;7204.24355442671;8011.437794538136;8032.83934321322;8218.58907054633;8375.37184711137;8391.16088391156;8359.498430094214;8374.162583741578;8444.915550844413;8481.448705834102;8501.659933602834;6875.209350924508;7003.789886303419;7006.789796306119;7013.964930175316;7020.087388639648;7439.367653749492;7464.813379665335;7562.697492100255;7571.432142589218;7594.8101297468;6959.4432445405255;6982.615956122462;7120.145582530129;7269.382102521345;7280.672369743268;6938.5143039986715;7056.717731290691;7093.432525397852;7133.072700548895;7212.567245965259;6987.161540615159;7046.612436316052;7149.857002860018;7152.213256541672;7152.356287934111;6516.706748196248;6527.967360163168;6556.213254409501;6556.3443655634055;6559.901601475886;6442.452391546583;6501.642409667514;6515.837104072247;6529.477641788741;6577.3422657735755 18:53:30 INFO - 2015-11-16 18:53:30,005 DEBUG : BROWSER_OUTPUT: |4;prototype.html;301.168893129771;302.92275469755214;303.51740732235754;307.6815495961679;313.1654141712337;6315.652639104847;6328.525360597956;6368.872622547547;6468.256150542689;6491.642959637218;6278.874422511547;6350.809475715736;6380.744770209186;6384.361563843613;6397.552171347996;4553.635709143261;4646.4191976003;4687.74217418041;4695.718256904596;4709.929351059737;4631.467381251148;4638.9536104638855;4643.930341044887;4682.812687492513;4696.577308042276;4623.976880115595;4637.420322459692;4638.420197475316;4643.767811609423;4644.349791029259;4637.582617564419;4650.232711602598;4651.046535460239;4662.650301227422;4671.11248862715;3832.386818109117;3971.5631280559405;3975.7216994810374;3980.2835489611857;3983.6098340995172;5892.086726557391;5974;5988.7604495820115;5997.370276121032;6014.248218972629;5385.919211211835;5391.218273350381;5394.7842086316505;5394.865128371783;5395.352557693062;6644.4020038196795;6686.465082793365;6693.799186024427;6693.866122677568;6694.665266736643;4263.275243208631;4301.311790113598;4348.108637729258;4357.237483440385;4370.322599997005;6912.688928998207;6995.125609298838;6998.720051197997;7000.9649951750425;7005.019297298382;4454.532274111171;4464.129494748558;4466.709663871838;4476;4488.5960263576435;4536.6143877770755;4539;4545.545445455428;4548.158590660738;4557.134144512532;5226.503482169188;5415.620906536505;5420.756065977041;5428.70142142186;5440.4287549807495;6771.966140169267;6782.457403407814;6784.76253331131;6796.898046529306;6804.6257455840405;1578.3528753211128;1600.7678886561384;1600.9439669611509;1602.5993501624594;1603.1663534961988;1024.364893765855;1026.8049070676698;1042.2652030318607;1046.6336782126348;1047.0314958663207;6558.934410655927;6581.80254592363;6589.9341006590275;6598.406143447017;6610.206775187008;6912.44700423975;6973.651317434108;6976.7558135465015;6994.33553812387;7035.8241043973285;6421.229452465734;6480.222373315138;6490.318516555788;6560.639164845884;6567.211934567882;3809.809509524568;3820.56063552695;3822.8470861165797;3832.9233415331537;3835.0412396900774;7249.275072492814;7316.670749816271;7422.851542969219;7446.478746487802;7476.925230747732;7189.676464559107;7277.417806575461;7297.963510182415;7337.26627337262;7341.449391295674;7237.819054523679;7416.887466880011;7443.590602516805;7449.627518624047;7464.962675186589;7031.613261270679;7070.7525236616475;7071.82320441993;7081.044059051962;7090.6100164491445;6936.237013928565;6965.512414131165;6971.65141742921;6989.580625162506;7029.26192749754;7217.097862767154;7329.596872172082;7403.407727381689;7428.665710042953;7432.925670743223;4522.366868638459;4576.58810707038;4584.426946631671;4588.587027167571;4598.3102534620075;6956.443484521327;6981.0924579804305;6999.51003429755;7005.474589405917;7008.334208250208;6645.734170633314;6751.358620931003;6759;6782.457403407617;6798.830029249309;6755.1556055493065;6774.390304872585;6782.423494003065;6782.830429239309;6785;6744.055832183596;6753.696083676148;6754.8649027020165;6758.831029224112;6768.898466523105;6774.525783195129;6856.485763567852;6875.243723190345;6880.105586273752;6882.621455819978;6632;6691.2639609643875;6692.464602831665;6693.799186024427;6701.128853249046 18:53:30 INFO - 2015-11-16 18:53:30,006 DEBUG : BROWSER_OUTPUT: |5;yui.html;780.8165081205916;786.0331791895968;787.2088551006237;850.3069997951669;867.20217399992;14042.227677477747;14218.644533886658;14370.856291437109;14372.928135359321;14380.712385752291;13703.794443083338;13774.65563360914;13787.207663003821;13807.723845523084;13814.79277810831;815.2866242038232;828.8176601147737;834.8121672623672;839.4459656626627;839.7942504086508;820.2003047029128;821.6220538552274;826.6610689617258;829.3862541719145;829.7427797382801;860.0797147052656;860.6514361683497;861.1216559109704;862.3704695572236;864.8745931839879;851.1786126388034;855.2516548020482;855.3029281135854;856.7344123321728;856.8629019356873;628.4155735166294;628.7956414165369;630.2877748144567;631.958922670025;632.1529150937765;13672.726545469035;13768.862311376859;13782.724345513034;13812.37844297009;13881.722365552632;10052;10366.999999999925;10412.114970227463;10534.947325263402;11171.273867198606;10082.24383171265;10204.438755868425;10222.539985700661;10270.89729102707;10332.586696532206;3240.4815229563155;3261.2010057535817;3306.8677252909856;3360.630330663625;3390;46396.768016160044;46411.30383044257;46487.302690459335;46494.37269695578;46523;7872.606369681493;7884;7926.405519586054;7946.523208607502;7951.522908625501;12250.754984900252;12309.876901230873;12353.876461235452;12377.62867113988;12413.44139513724;6636.303188165173;6849.349311815369;6868.862622747517;7047.295270472911;7122.608256545836;4284.078923031563;4323.48118225815;4449.221386257392;4453.4433195850515;4476.4180656514445;2660.8536530490624;2693.4074503609177;2699.987504685743;2716.2530304166116;2717.320669832542;433.9956600434018;436.88204184870546;440.9184300904279;441.31596026159326;443.81803460581006;553.236533583652;643.9092356687879;654.9226522370768;694.1947341084318;694.9339812717784;8075.111737708848;8101;8372.790680233044;8778.692745753995;8897.510636915033;627.7771391156074;691.339770519153;712.8360477090298;715.8174665460274;729.923358047408;4130.091379896418;4180.435641188462;4192.203481338536;4207.558206388347;4289.485261768607;55563;55609.1658625121;57000;57766;57836.71081644565;48718.5128148714;49356;50285.24572131421;50312.99374012499;50486;45822.77088614602;45974.77012614915;46244;46447.76776116165;46606.300905486445;8376.078631350425;8863.290936725176;8944.262556100542;9031.096890310917;9277.304202184729;33608;33996.49005264873;34471.65528344785;34618.82690586531;35048.299034019685;42008.57991420047;42945.570544294154;43347.34978975381;43921.34117988169;44819.103617926805;8118.025836899374;8371.288440482627;8430.199131082538;8529.616167272363;8935.821283574422;12109.878901210875;12189.390530473618;12212.755744884875;12454.564090256797;12687.238765674088;10755.516001779783;10858.511366988347;10991.670249892515;11040;11578.594749183738;10460.476976151314;10628.096611788085;10660.786784264426;10685.412302323446;10900.40047797347;11401.315921044765;11568.47941842636;11961.820572691591;12086.818697719365;12110.333931633844;9736.464494452874;9837.458939758382;9904.603815847286;10093.339032415382;10196.490175491344;9143.77140571491;9384.390014649027;9846.852297215404;9872.259580531345;9878.703638890845 18:53:30 INFO - 2015-11-16 18:53:30,006 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:53:30 INFO - 2015-11-16 18:53:30,007 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:53:30 INFO - 2015-11-16 18:53:30,007 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,286 18:53:30 INFO - 2015-11-16 18:53:30,007 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:53:30 INFO - 2015-11-16 18:53:30,007 DEBUG : BROWSER_OUTPUT: __startTimestamp1447728809996__endTimestamp 18:53:30 INFO - 2015-11-16 18:53:30,007 DEBUG : BROWSER_OUTPUT: 18:53:30 INFO - 2015-11-16 18:53:30,007 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:53:30 INFO - 2015-11-16 18:53:30,007 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:53:30 INFO - 2015-11-16 18:53:30,008 DEBUG : BROWSER_OUTPUT: 18:53:30 INFO - 2015-11-16 18:53:30,008 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5654.94 Median:5893.85 stddev:653.28 (11.1%) stddev-sans-first:628.06 18:53:30 INFO - 2015-11-16 18:53:30,008 DEBUG : BROWSER_OUTPUT: Values: 3275.7 3298.9 3310.2 3313.9 3350.3 5469.2 5644.2 5650.3 5687.6 5688.8 5495.1 5530.8 5560.2 5560.7 5618.5 5056.3 5096.2 5185.2 5185.3 5232.8 5167.4 5168.3 5216.4 5228.6 5238.6 5009.7 5038.5 5110.0 5166.6 5185.7 5172.1 5180.5 5190.3 5197.3 5236.1 4997.5 5162.6 5164.5 5166.2 5167.4 5302.9 5421.0 5452.5 5455.6 5464.8 6077.1 6113.1 6135.1 6135.2 6164.0 6094.4 6157.8 6161.3 6161.9 6177.1 5644.9 5707.2 5751.2 5763.9 5817.4 6204.1 6224.1 6248.8 6271.5 6281.8 6044.2 6047.3 6051.4 6060.8 6106.0 5954.0 6003.4 6068.6 6068.7 6120.1 6047.0 6153.9 6164.9 6165.0 6165.5 5923.0 6077.0 6131.2 6131.4 6132.2 4581.5 4631.8 4653.1 4654.9 4675.2 4128.8 4132.6 4135.3 4141.3 4169.6 5830.8 5847.9 5848.9 5849.5 5893.5 5943.7 6021.4 6076.2 6104.7 6108.5 5833.1 5925.4 5927.0 5944.9 5947.4 5109.1 5359.9 5364.4 5379.5 5385.0 6257.0 6263.1 6472.3 6475.9 6490.7 6118.6 6126.5 6148.7 6152.1 6159.5 6132.7 6224.7 6392.1 6396.9 6419.9 5910.4 5927.8 5958.7 5975.6 5995.8 6056.2 6060.8 6105.4 6131.4 6172.8 5825.9 5833.1 5917.5 5921.0 5958.8 5956.4 5958.3 5968.0 5977.0 5978.4 5802.3 5810.9 5832.4 5834.4 5846.4 5771.2 5941.3 5947.6 5977.9 6120.6 5839.8 5861.8 5880.7 5893.9 5900.1 18:53:30 INFO - 2015-11-16 18:53:30,008 DEBUG : BROWSER_OUTPUT: 18:53:30 INFO - 2015-11-16 18:53:30,008 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46794.47 Median:34745.15 stddev:77299.33 (222.5%) stddev-sans-first:77438.22 18:53:30 INFO - 2015-11-16 18:53:30,008 DEBUG : BROWSER_OUTPUT: Values: 559.8 596.6 603.3 607.1 608.5 39218.6 40574.4 40729.2 40731.8 40869.6 43368.0 44232.3 44342.6 44368.0 44376.6 8921.9 9000.3 9080.6 9082.3 9086.5 8606.2 8689.8 8714.9 8742.9 8745.6 8817.5 8874.5 8896.7 8928.1 8950.4 8850.4 8921.5 8940.8 8944.8 8958.5 8825.6 8944.1 8950.1 8950.5 8959.6 40715.6 40841.2 41106.4 41209.2 41293.6 3403.7 3444.8 3456.2 3565.8 3824.7 30335.0 30564.5 30788.8 30794.2 30915.8 3415.7 3490.4 3575.8 3627.8 3629.0 262541.0 263470.7 263933.0 264050.0 265286.0 61433.4 61583.4 61812.7 62105.0 62167.4 60493.7 63234.4 64583.4 67673.7 67796.3 15158.5 15174.4 15196.1 15252.0 15415.8 11628.7 11643.5 11671.8 11682.9 11728.8 20502.4 20964.8 21085.9 21093.5 21094.0 7602.5 7788.8 7790.8 7814.9 7841.8 1022.6 1054.4 1068.5 1071.2 1088.0 28331.9 28927.9 29363.6 29465.4 29489.6 1003.9 1008.7 1026.5 1039.8 1124.1 13584.1 13683.7 13991.7 14022.6 14032.5 315963.0 319785.0 323030.0 324673.0 324852.0 53617.5 53772.7 53797.2 53809.5 54089.7 1371.1 1380.0 1388.6 1393.2 1394.1 25747.2 26696.7 26752.9 26953.6 27186.0 45705.1 45738.8 45788.1 45902.3 45918.8 295565.0 298118.0 299452.0 299549.0 300144.0 32004.5 32448.5 32563.2 32720.2 32739.3 40127.4 43475.0 43901.8 44644.3 44950.0 33781.0 33831.5 33875.5 34065.8 34784.8 33939.8 34463.7 34705.5 36679.4 36879.0 36293.6 36388.8 36516.1 36637.6 36653.0 28749.3 29138.4 30799.4 30836.8 31049.2 24866.9 25204.6 25253.0 25319.4 25320.0 18:53:30 INFO - 2015-11-16 18:53:30,008 DEBUG : BROWSER_OUTPUT: 18:53:30 INFO - 2015-11-16 18:53:30,008 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28373.63 Median:393.67 stddev:86758.77 (22038.3%) stddev-sans-first:86976.63 18:53:30 INFO - 2015-11-16 18:53:30,010 DEBUG : BROWSER_OUTPUT: Values: 346.8 350.3 353.0 354.2 354.9 12522.4 12946.2 16460.8 17282.7 18570.5 10873.1 10905.6 11273.2 11852.6 12063.2 4588.4 4680.2 4693.8 4696.0 4704.4 4867.8 4973.7 4978.8 5006.1 5008.0 3489.6 3568.8 4757.3 4958.2 4958.2 6582.9 6740.0 6755.9 6775.7 6784.4 6338.5 6472.8 6484.4 6514.2 6524.2 21005.8 22081.0 22883.0 23268.5 23501.1 2126.6 2234.5 2261.1 2267.3 2284.4 14177.2 14267.5 14436.4 14549.9 14944.0 1951.8 1974.5 1981.8 2008.5 2065.6 65842.7 69044.7 69126.0 69415.7 69920.0 15101.0 15916.2 15953.8 16019.2 16039.8 24135.5 24149.9 24495.0 24554.6 24642.3 9311.8 9327.6 9373.7 9457.5 9479.9 8004.1 8004.9 8008.9 8051.0 8061.6 7682.8 7696.3 7746.9 7749.1 7750.8 3214.5 3259.3 3259.8 3278.8 3315.9 389.9 397.5 399.9 400.7 502.8 9897.7 10070.6 10225.7 10607.3 10880.5 400.4 427.2 436.7 437.7 439.5 5861.2 5923.9 5962.9 5964.3 6019.8 514333.0 521390.0 533550.0 534589.0 544865.0 77886.2 78059.6 78451.2 80129.0 81388.2 456.8 457.3 457.4 459.4 462.5 9890.8 10055.8 10075.7 10079.9 10184.8 33455.7 33845.2 34027.7 34694.3 35212.3 46745.0 46787.4 47429.3 47443.8 48083.5 6835.2 6859.3 6886.0 6922.1 6927.4 12097.9 12466.4 12616.7 12626.9 12721.6 10872.4 10946.2 11066.2 11147.7 11173.9 10469.4 10844.6 11017.3 11057.4 11066.4 10715.3 10766.3 10853.1 11138.8 11169.2 6514.9 6970.9 7035.1 7037.4 7052.3 10898.8 11152.1 11156.9 11210.6 11294.4 18:53:30 INFO - 2015-11-16 18:53:30,010 DEBUG : BROWSER_OUTPUT: 18:53:30 INFO - 2015-11-16 18:53:30,010 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5404.81 Median:6472.05 stddev:2788.04 (43.1%) stddev-sans-first:2780.52 18:53:30 INFO - 2015-11-16 18:53:30,010 DEBUG : BROWSER_OUTPUT: Values: 1513.9 1682.2 1728.7 1732.0 1762.4 7546.1 7690.6 7765.5 7783.1 7906.1 7787.9 7800.5 7817.8 7887.6 7895.4 2112.3 2129.0 2138.2 2142.6 2167.0 2208.4 2248.4 2272.3 2272.8 2283.3 2217.2 2233.0 2257.2 2264.0 2269.5 2223.0 2224.9 2239.5 2252.1 2253.0 2288.7 2305.6 2311.8 2315.8 2322.3 7675.5 7722.9 7736.3 7743.3 7752.5 4452.9 4457.8 4465.2 4489.1 4499.6 2984.3 2984.8 3089.9 3102.2 3108.4 1011.5 1023.8 1027.8 1030.8 1047.8 10480.4 10502.8 10508.3 10524.1 10579.7 3977.3 3979.9 4025.4 4035.4 4129.9 8651.7 8673.8 8685.7 8699.5 8705.1 4557.5 4566.6 4569.7 4579.9 4603.0 4179.7 4200.6 4203.0 4234.6 4241.2 3417.0 3423.9 3433.5 3434.4 3448.5 1060.4 1074.3 1078.0 1092.7 1103.4 1067.9 1078.9 1150.0 1238.5 1335.8 6927.4 7002.3 7010.3 7030.0 7093.7 1133.9 1144.5 1154.3 1157.3 1160.4 5713.8 5762.2 5764.8 5793.1 5806.0 9039.2 9053.4 9158.9 9304.8 9336.8 9009.8 9120.7 9140.3 9148.4 9153.9 7144.5 7202.5 7240.3 7294.3 7310.6 7094.0 7148.9 7150.5 7202.7 7204.2 8011.4 8032.8 8218.6 8375.4 8391.2 8359.5 8374.2 8444.9 8481.4 8501.7 6875.2 7003.8 7006.8 7014.0 7020.1 7439.4 7464.8 7562.7 7571.4 7594.8 6959.4 6982.6 7120.1 7269.4 7280.7 6938.5 7056.7 7093.4 7133.1 7212.6 6987.2 7046.6 7149.9 7152.2 7152.4 6516.7 6528.0 6556.2 6556.3 6559.9 6442.5 6501.6 6515.8 6529.5 6577.3 18:53:30 INFO - 2015-11-16 18:53:30,010 DEBUG : BROWSER_OUTPUT: 18:53:30 INFO - 2015-11-16 18:53:30,010 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5598.84 Median:6485.27 stddev:1786.37 (27.5%) stddev-sans-first:1746.57 18:53:30 INFO - 2015-11-16 18:53:30,011 DEBUG : BROWSER_OUTPUT: Values: 301.2 302.9 303.5 307.7 313.2 6315.7 6328.5 6368.9 6468.3 6491.6 6278.9 6350.8 6380.7 6384.4 6397.6 4553.6 4646.4 4687.7 4695.7 4709.9 4631.5 4639.0 4643.9 4682.8 4696.6 4624.0 4637.4 4638.4 4643.8 4644.3 4637.6 4650.2 4651.0 4662.7 4671.1 3832.4 3971.6 3975.7 3980.3 3983.6 5892.1 5974.0 5988.8 5997.4 6014.2 5385.9 5391.2 5394.8 5394.9 5395.4 6644.4 6686.5 6693.8 6693.9 6694.7 4263.3 4301.3 4348.1 4357.2 4370.3 6912.7 6995.1 6998.7 7001.0 7005.0 4454.5 4464.1 4466.7 4476.0 4488.6 4536.6 4539.0 4545.5 4548.2 4557.1 5226.5 5415.6 5420.8 5428.7 5440.4 6772.0 6782.5 6784.8 6796.9 6804.6 1578.4 1600.8 1600.9 1602.6 1603.2 1024.4 1026.8 1042.3 1046.6 1047.0 6558.9 6581.8 6589.9 6598.4 6610.2 6912.4 6973.7 6976.8 6994.3 7035.8 6421.2 6480.2 6490.3 6560.6 6567.2 3809.8 3820.6 3822.8 3832.9 3835.0 7249.3 7316.7 7422.9 7446.5 7476.9 7189.7 7277.4 7298.0 7337.3 7341.4 7237.8 7416.9 7443.6 7449.6 7465.0 7031.6 7070.8 7071.8 7081.0 7090.6 6936.2 6965.5 6971.7 6989.6 7029.3 7217.1 7329.6 7403.4 7428.7 7432.9 4522.4 4576.6 4584.4 4588.6 4598.3 6956.4 6981.1 6999.5 7005.5 7008.3 6645.7 6751.4 6759.0 6782.5 6798.8 6755.2 6774.4 6782.4 6782.8 6785.0 6744.1 6753.7 6754.9 6758.8 6768.9 6774.5 6856.5 6875.2 6880.1 6882.6 6632.0 6691.3 6692.5 6693.8 6701.1 18:53:30 INFO - 2015-11-16 18:53:30,012 DEBUG : BROWSER_OUTPUT: 18:53:30 INFO - 2015-11-16 18:53:30,012 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13312.01 Median:46404.04 stddev:15634.25 (33.7%) stddev-sans-first:15649.79 18:53:30 INFO - 2015-11-16 18:53:30,013 DEBUG : BROWSER_OUTPUT: Values: 780.8 786.0 787.2 850.3 867.2 14042.2 14218.6 14370.9 14372.9 14380.7 13703.8 13774.7 13787.2 13807.7 13814.8 815.3 828.8 834.8 839.4 839.8 820.2 821.6 826.7 829.4 829.7 860.1 860.7 861.1 862.4 864.9 851.2 855.3 855.3 856.7 856.9 628.4 628.8 630.3 632.0 632.2 13672.7 13768.9 13782.7 13812.4 13881.7 10052.0 10367.0 10412.1 10534.9 11171.3 10082.2 10204.4 10222.5 10270.9 10332.6 3240.5 3261.2 3306.9 3360.6 3390.0 46396.8 46411.3 46487.3 46494.4 46523.0 7872.6 7884.0 7926.4 7946.5 7951.5 12250.8 12309.9 12353.9 12377.6 12413.4 6636.3 6849.3 6868.9 7047.3 7122.6 4284.1 4323.5 4449.2 4453.4 4476.4 2660.9 2693.4 2700.0 2716.3 2717.3 434.0 436.9 440.9 441.3 443.8 553.2 643.9 654.9 694.2 694.9 8075.1 8101.0 8372.8 8778.7 8897.5 627.8 691.3 712.8 715.8 729.9 4130.1 4180.4 4192.2 4207.6 4289.5 55563.0 55609.2 57000.0 57766.0 57836.7 48718.5 49356.0 50285.2 50313.0 50486.0 45822.8 45974.8 46244.0 46447.8 46606.3 8376.1 8863.3 8944.3 9031.1 9277.3 33608.0 33996.5 34471.7 34618.8 35048.3 42008.6 42945.6 43347.3 43921.3 44819.1 8118.0 8371.3 8430.2 8529.6 8935.8 12109.9 12189.4 12212.8 12454.6 12687.2 10755.5 10858.5 10991.7 11040.0 11578.6 10460.5 10628.1 10660.8 10685.4 10900.4 11401.3 11568.5 11961.8 12086.8 12110.3 9736.5 9837.5 9904.6 10093.3 10196.5 9143.8 9384.4 9846.9 9872.3 9878.7 18:53:30 INFO - 2015-11-16 18:53:30,013 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:53:30 INFO - 2015-11-16 18:53:30,013 DEBUG : BROWSER_OUTPUT: 18:53:30 INFO - 2015-11-16 18:53:30,663 INFO : Browser exited with error code: 0 18:53:30 INFO - 2015-11-16 18:53:30,684 INFO : Completed test dromaeo_css (00:18:30) 18:53:30 INFO - 2015-11-16 18:53:30,684 INFO : Starting test kraken 18:53:30 INFO - 2015-11-16 18:53:30,684 DEBUG : operating with platform_type : linux_ 18:53:30 INFO - 2015-11-16 18:53:30,684 INFO : Initialising browser for kraken test... 18:53:30 INFO - 2015-11-16 18:53:30,690 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpD0pVgT/profile http://localhost:36005/getInfo.html 18:53:35 INFO - 2015-11-16 18:53:35,363 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:53:35 INFO - 2015-11-16 18:53:35,363 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:53:35 INFO - 2015-11-16 18:53:35,363 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:53:35 INFO - 2015-11-16 18:53:35,363 DEBUG : BROWSER_OUTPUT: __metrics 18:53:36 INFO - 2015-11-16 18:53:36,562 INFO : Browser initialized. 18:53:36 INFO - 2015-11-16 18:53:36,563 INFO : Running cycle 1/1 for kraken test... 18:53:36 INFO - 2015-11-16 18:53:36,563 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpD0pVgT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:53:48 INFO - 2015-11-16 18:53:48,260 DEBUG : BROWSER_OUTPUT: RSS: Main: 141156352 18:53:48 INFO - 2015-11-16 18:53:48,260 DEBUG : BROWSER_OUTPUT: 18:53:50 INFO - 2015-11-16 18:53:50,735 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36005/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36005/tests/kraken/driver.html?testName=audio-beat-detection) 18:53:51 INFO - 2015-11-16 18:53:51,336 DEBUG : BROWSER_OUTPUT: RSS: Main: 141537280 18:53:51 INFO - 2015-11-16 18:53:51,336 DEBUG : BROWSER_OUTPUT: 18:53:53 INFO - 2015-11-16 18:53:53,945 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36005/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36005/tests/kraken/driver.html?testName=audio-dft) 18:53:54 INFO - 2015-11-16 18:53:54,538 DEBUG : BROWSER_OUTPUT: RSS: Main: 140427264 18:53:54 INFO - 2015-11-16 18:53:54,538 DEBUG : BROWSER_OUTPUT: 18:53:57 INFO - 2015-11-16 18:53:57,376 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36005/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36005/tests/kraken/driver.html?testName=audio-fft) 18:53:57 INFO - 2015-11-16 18:53:57,957 DEBUG : BROWSER_OUTPUT: RSS: Main: 137461760 18:53:57 INFO - 2015-11-16 18:53:57,957 DEBUG : BROWSER_OUTPUT: 18:53:59 INFO - 2015-11-16 18:53:59,949 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36005/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36005/tests/kraken/driver.html?testName=audio-oscillator) 18:54:00 INFO - 2015-11-16 18:54:00,557 DEBUG : BROWSER_OUTPUT: RSS: Main: 136863744 18:54:00 INFO - 2015-11-16 18:54:00,557 DEBUG : BROWSER_OUTPUT: 18:54:02 INFO - 2015-11-16 18:54:02,755 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36005/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36005/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:54:03 INFO - 2015-11-16 18:54:03,342 DEBUG : BROWSER_OUTPUT: RSS: Main: 137162752 18:54:03 INFO - 2015-11-16 18:54:03,343 DEBUG : BROWSER_OUTPUT: 18:54:06 INFO - 2015-11-16 18:54:06,341 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36005/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36005/tests/kraken/driver.html?testName=imaging-darkroom) 18:54:06 INFO - 2015-11-16 18:54:06,943 DEBUG : BROWSER_OUTPUT: RSS: Main: 138371072 18:54:06 INFO - 2015-11-16 18:54:06,943 DEBUG : BROWSER_OUTPUT: 18:54:10 INFO - 2015-11-16 18:54:10,343 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36005/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36005/tests/kraken/driver.html?testName=imaging-desaturate) 18:54:10 INFO - 2015-11-16 18:54:10,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 138510336 18:54:10 INFO - 2015-11-16 18:54:10,925 DEBUG : BROWSER_OUTPUT: 18:54:13 INFO - 2015-11-16 18:54:13,795 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36005/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36005/tests/kraken/driver.html?testName=json-parse-financial) 18:54:14 INFO - 2015-11-16 18:54:14,388 DEBUG : BROWSER_OUTPUT: RSS: Main: 138371072 18:54:14 INFO - 2015-11-16 18:54:14,388 DEBUG : BROWSER_OUTPUT: 18:54:15 INFO - 2015-11-16 18:54:15,970 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36005/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36005/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:54:16 INFO - 2015-11-16 18:54:16,552 DEBUG : BROWSER_OUTPUT: RSS: Main: 139653120 18:54:16 INFO - 2015-11-16 18:54:16,552 DEBUG : BROWSER_OUTPUT: 18:54:18 INFO - 2015-11-16 18:54:18,367 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36005/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36005/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:54:18 INFO - 2015-11-16 18:54:18,968 DEBUG : BROWSER_OUTPUT: RSS: Main: 139063296 18:54:18 INFO - 2015-11-16 18:54:18,969 DEBUG : BROWSER_OUTPUT: 18:54:21 INFO - 2015-11-16 18:54:21,040 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36005/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36005/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:54:21 INFO - 2015-11-16 18:54:21,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 139554816 18:54:21 INFO - 2015-11-16 18:54:21,622 DEBUG : BROWSER_OUTPUT: 18:54:24 INFO - 2015-11-16 18:54:24,068 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36005/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36005/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:54:24 INFO - 2015-11-16 18:54:24,654 DEBUG : BROWSER_OUTPUT: RSS: Main: 140476416 18:54:24 INFO - 2015-11-16 18:54:24,654 DEBUG : BROWSER_OUTPUT: 18:54:27 INFO - 2015-11-16 18:54:27,248 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36005/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36005/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:54:27 INFO - 2015-11-16 18:54:27,833 DEBUG : BROWSER_OUTPUT: RSS: Main: 139022336 18:54:27 INFO - 2015-11-16 18:54:27,834 DEBUG : BROWSER_OUTPUT: 18:54:29 INFO - 2015-11-16 18:54:29,529 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36005/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36005/tests/kraken/driver.html?testName=ai-astar) 18:54:29 INFO - 2015-11-16 18:54:29,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 140025856 18:54:29 INFO - 2015-11-16 18:54:29,779 DEBUG : BROWSER_OUTPUT: 18:54:29 INFO - 2015-11-16 18:54:29,783 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:54:29 INFO - 2015-11-16 18:54:29,783 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:54:29 INFO - 2015-11-16 18:54:29,783 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:54:29 INFO - 2015-11-16 18:54:29,783 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:54:29 INFO - 2015-11-16 18:54:29,784 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;104;113;111;110;122;110;110;110;110 18:54:29 INFO - 2015-11-16 18:54:29,784 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;126;153;164;127;153;152;127;158;125 18:54:29 INFO - 2015-11-16 18:54:29,784 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;160;162;162;163;164;161;159;169;165 18:54:29 INFO - 2015-11-16 18:54:29,784 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;72;72;72;73;145;75;72;72 18:54:29 INFO - 2015-11-16 18:54:29,784 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;89;135;89;90;90;129;90;90;137 18:54:29 INFO - 2015-11-16 18:54:29,785 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;111;110;109;111;109;110;110;110 18:54:29 INFO - 2015-11-16 18:54:29,785 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;148;147;147;145;146;146;147;146;146 18:54:29 INFO - 2015-11-16 18:54:29,785 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;97;96;97;95;96 18:54:29 INFO - 2015-11-16 18:54:29,785 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;61;61;60;61;61;60;61;66;59 18:54:29 INFO - 2015-11-16 18:54:29,785 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;70;68;68;68;68;69;68 18:54:29 INFO - 2015-11-16 18:54:29,786 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;84;92;85;86;91;84;84;83;84 18:54:29 INFO - 2015-11-16 18:54:29,786 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;128;116;129;119;129;129;116;120;117 18:54:29 INFO - 2015-11-16 18:54:29,786 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;152;152;151;148;142;155;154;153;142;149 18:54:29 INFO - 2015-11-16 18:54:29,786 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;68;72;66;74;68;68;67;67;66 18:54:29 INFO - 2015-11-16 18:54:29,786 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:54:29 INFO - 2015-11-16 18:54:29,786 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:54:29 INFO - 2015-11-16 18:54:29,786 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,721 18:54:29 INFO - 2015-11-16 18:54:29,787 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:54:29 INFO - 2015-11-16 18:54:29,787 DEBUG : BROWSER_OUTPUT: __startTimestamp1447728869781__endTimestamp 18:54:29 INFO - 2015-11-16 18:54:29,787 DEBUG : BROWSER_OUTPUT: 18:54:29 INFO - 2015-11-16 18:54:29,788 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:54:29 INFO - 2015-11-16 18:54:29,788 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:54:29 INFO - 2015-11-16 18:54:29,788 DEBUG : BROWSER_OUTPUT: 18:54:29 INFO - 2015-11-16 18:54:29,788 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.10 Median:110.50 stddev:4.46 (4.0%) stddev-sans-first:4.73 18:54:29 INFO - 2015-11-16 18:54:29,788 DEBUG : BROWSER_OUTPUT: Values: 111.0 104.0 113.0 111.0 110.0 122.0 110.0 110.0 110.0 110.0 18:54:29 INFO - 2015-11-16 18:54:29,788 DEBUG : BROWSER_OUTPUT: 18:54:29 INFO - 2015-11-16 18:54:29,788 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.30 Median:152.50 stddev:15.26 (10.0%) stddev-sans-first:16.09 18:54:29 INFO - 2015-11-16 18:54:29,789 DEBUG : BROWSER_OUTPUT: Values: 148.0 126.0 153.0 164.0 127.0 153.0 152.0 127.0 158.0 125.0 18:54:29 INFO - 2015-11-16 18:54:29,789 DEBUG : BROWSER_OUTPUT: 18:54:29 INFO - 2015-11-16 18:54:29,789 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.90 Median:163.50 stddev:2.85 (1.7%) stddev-sans-first:2.99 18:54:29 INFO - 2015-11-16 18:54:29,789 DEBUG : BROWSER_OUTPUT: Values: 164.0 160.0 162.0 162.0 163.0 164.0 161.0 159.0 169.0 165.0 18:54:29 INFO - 2015-11-16 18:54:29,789 DEBUG : BROWSER_OUTPUT: 18:54:29 INFO - 2015-11-16 18:54:29,789 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.80 Median:72.00 stddev:22.93 (31.8%) stddev-sans-first:24.15 18:54:29 INFO - 2015-11-16 18:54:29,790 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 72.0 72.0 72.0 73.0 145.0 75.0 72.0 72.0 18:54:29 INFO - 2015-11-16 18:54:29,790 DEBUG : BROWSER_OUTPUT: 18:54:29 INFO - 2015-11-16 18:54:29,790 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.90 Median:90.00 stddev:21.33 (23.7%) stddev-sans-first:22.10 18:54:29 INFO - 2015-11-16 18:54:29,790 DEBUG : BROWSER_OUTPUT: Values: 90.0 89.0 135.0 89.0 90.0 90.0 129.0 90.0 90.0 137.0 18:54:29 INFO - 2015-11-16 18:54:29,790 DEBUG : BROWSER_OUTPUT: 18:54:29 INFO - 2015-11-16 18:54:29,790 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 18:54:29 INFO - 2015-11-16 18:54:29,790 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 111.0 110.0 109.0 111.0 109.0 110.0 110.0 110.0 18:54:29 INFO - 2015-11-16 18:54:29,790 DEBUG : BROWSER_OUTPUT: 18:54:29 INFO - 2015-11-16 18:54:29,790 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:1.16 (0.8%) stddev-sans-first:0.88 18:54:29 INFO - 2015-11-16 18:54:29,790 DEBUG : BROWSER_OUTPUT: Values: 149.0 148.0 147.0 147.0 145.0 146.0 146.0 147.0 146.0 146.0 18:54:29 INFO - 2015-11-16 18:54:29,791 DEBUG : BROWSER_OUTPUT: 18:54:29 INFO - 2015-11-16 18:54:29,791 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 18:54:29 INFO - 2015-11-16 18:54:29,791 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 97.0 96.0 97.0 95.0 96.0 18:54:29 INFO - 2015-11-16 18:54:29,791 DEBUG : BROWSER_OUTPUT: 18:54:29 INFO - 2015-11-16 18:54:29,791 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.10 Median:61.00 stddev:1.85 (3.0%) stddev-sans-first:1.96 18:54:29 INFO - 2015-11-16 18:54:29,791 DEBUG : BROWSER_OUTPUT: Values: 61.0 61.0 61.0 60.0 61.0 61.0 60.0 61.0 66.0 59.0 18:54:29 INFO - 2015-11-16 18:54:29,791 DEBUG : BROWSER_OUTPUT: 18:54:29 INFO - 2015-11-16 18:54:29,791 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 18:54:29 INFO - 2015-11-16 18:54:29,792 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 70.0 68.0 68.0 68.0 68.0 69.0 68.0 18:54:29 INFO - 2015-11-16 18:54:29,792 DEBUG : BROWSER_OUTPUT: 18:54:29 INFO - 2015-11-16 18:54:29,792 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:85.00 stddev:3.12 (3.7%) stddev-sans-first:3.30 18:54:29 INFO - 2015-11-16 18:54:29,792 DEBUG : BROWSER_OUTPUT: Values: 85.0 84.0 92.0 85.0 86.0 91.0 84.0 84.0 83.0 84.0 18:54:29 INFO - 2015-11-16 18:54:29,792 DEBUG : BROWSER_OUTPUT: 18:54:29 INFO - 2015-11-16 18:54:29,792 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.50 Median:125.00 stddev:5.68 (4.5%) stddev-sans-first:6.02 18:54:29 INFO - 2015-11-16 18:54:29,792 DEBUG : BROWSER_OUTPUT: Values: 122.0 128.0 116.0 129.0 119.0 129.0 129.0 116.0 120.0 117.0 18:54:29 INFO - 2015-11-16 18:54:29,793 DEBUG : BROWSER_OUTPUT: 18:54:29 INFO - 2015-11-16 18:54:29,793 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.80 Median:152.00 stddev:4.61 (3.0%) stddev-sans-first:4.82 18:54:29 INFO - 2015-11-16 18:54:29,793 DEBUG : BROWSER_OUTPUT: Values: 152.0 152.0 151.0 148.0 142.0 155.0 154.0 153.0 142.0 149.0 18:54:29 INFO - 2015-11-16 18:54:29,793 DEBUG : BROWSER_OUTPUT: 18:54:29 INFO - 2015-11-16 18:54:29,793 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.00 stddev:2.63 (3.9%) stddev-sans-first:2.74 18:54:29 INFO - 2015-11-16 18:54:29,793 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 72.0 66.0 74.0 68.0 68.0 67.0 67.0 66.0 18:54:29 INFO - 2015-11-16 18:54:29,793 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:54:29 INFO - 2015-11-16 18:54:29,793 DEBUG : BROWSER_OUTPUT: 18:54:30 INFO - 2015-11-16 18:54:30,683 INFO : Browser exited with error code: 0 18:54:30 INFO - 2015-11-16 18:54:30,735 INFO : Completed test kraken (00:01:00) 18:54:30 INFO - 2015-11-16 18:54:30,735 INFO : Starting test v8_7 18:54:30 INFO - 2015-11-16 18:54:30,735 DEBUG : operating with platform_type : linux_ 18:54:30 INFO - 2015-11-16 18:54:30,735 INFO : Initialising browser for v8_7 test... 18:54:30 INFO - 2015-11-16 18:54:30,741 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpE8GoNE/profile http://localhost:36005/getInfo.html 18:54:35 INFO - 2015-11-16 18:54:35,455 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:54:35 INFO - 2015-11-16 18:54:35,455 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:54:35 INFO - 2015-11-16 18:54:35,455 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:54:35 INFO - 2015-11-16 18:54:35,455 DEBUG : BROWSER_OUTPUT: __metrics 18:54:36 INFO - 2015-11-16 18:54:36,598 INFO : Browser initialized. 18:54:36 INFO - 2015-11-16 18:54:36,599 INFO : Running cycle 1/1 for v8_7 test... 18:54:36 INFO - 2015-11-16 18:54:36,599 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpE8GoNE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:54:48 INFO - 2015-11-16 18:54:48,320 DEBUG : BROWSER_OUTPUT: RSS: Main: 141565952 18:54:48 INFO - 2015-11-16 18:54:48,320 DEBUG : BROWSER_OUTPUT: 18:55:09 INFO - 2015-11-16 18:55:09,747 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36005/tests/v8_7/run.html (next: http://localhost:36005/tests/v8_7/run.html) 18:55:09 INFO - 2015-11-16 18:55:09,997 DEBUG : BROWSER_OUTPUT: RSS: Main: 138526720 18:55:09 INFO - 2015-11-16 18:55:09,997 DEBUG : BROWSER_OUTPUT: 18:55:09 INFO - 2015-11-16 18:55:09,997 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:55:09 INFO - 2015-11-16 18:55:09,997 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:55:09 INFO - 2015-11-16 18:55:09,997 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:55:09 INFO - 2015-11-16 18:55:09,998 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:55:09 INFO - 2015-11-16 18:55:09,998 DEBUG : BROWSER_OUTPUT: |0;Richards;165.6451880072884 18:55:10 INFO - 2015-11-16 18:55:09,998 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.7608990505716 18:55:10 INFO - 2015-11-16 18:55:09,998 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.9654782116582 18:55:10 INFO - 2015-11-16 18:55:09,999 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5050.50505050505 18:55:10 INFO - 2015-11-16 18:55:09,999 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1051.5247108307046 18:55:10 INFO - 2015-11-16 18:55:09,999 DEBUG : BROWSER_OUTPUT: |5;Earley;716.8458781362007 18:55:10 INFO - 2015-11-16 18:55:10,000 DEBUG : BROWSER_OUTPUT: |6;Boyer;12228.915662650603 18:55:10 INFO - 2015-11-16 18:55:10,000 DEBUG : BROWSER_OUTPUT: |7;RegExp;24756.09756097561 18:55:10 INFO - 2015-11-16 18:55:10,000 DEBUG : BROWSER_OUTPUT: |8;Splay;749.4390426327599 18:55:10 INFO - 2015-11-16 18:55:10,000 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 18:55:10 INFO - 2015-11-16 18:55:10,000 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:55:10 INFO - 2015-11-16 18:55:10,000 DEBUG : BROWSER_OUTPUT: __startTimestamp1447728909995__endTimestamp 18:55:10 INFO - 2015-11-16 18:55:10,000 DEBUG : BROWSER_OUTPUT: 18:55:10 INFO - 2015-11-16 18:55:10,000 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:55:10 INFO - 2015-11-16 18:55:10,001 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:55:10 INFO - 2015-11-16 18:55:10,001 DEBUG : BROWSER_OUTPUT: 18:55:10 INFO - 2015-11-16 18:55:10,001 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.65 Median:165.65 stddev:0.00 (0.0%) 18:55:10 INFO - 2015-11-16 18:55:10,001 DEBUG : BROWSER_OUTPUT: Values: 165.6 18:55:10 INFO - 2015-11-16 18:55:10,001 DEBUG : BROWSER_OUTPUT: 18:55:10 INFO - 2015-11-16 18:55:10,001 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.76 Median:193.76 stddev:0.00 (0.0%) 18:55:10 INFO - 2015-11-16 18:55:10,001 DEBUG : BROWSER_OUTPUT: Values: 193.8 18:55:10 INFO - 2015-11-16 18:55:10,001 DEBUG : BROWSER_OUTPUT: 18:55:10 INFO - 2015-11-16 18:55:10,002 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.97 Median:282.97 stddev:0.00 (0.0%) 18:55:10 INFO - 2015-11-16 18:55:10,002 DEBUG : BROWSER_OUTPUT: Values: 283.0 18:55:10 INFO - 2015-11-16 18:55:10,002 DEBUG : BROWSER_OUTPUT: 18:55:10 INFO - 2015-11-16 18:55:10,002 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5050.51 Median:5050.51 stddev:0.00 (0.0%) 18:55:10 INFO - 2015-11-16 18:55:10,002 DEBUG : BROWSER_OUTPUT: Values: 5050.5 18:55:10 INFO - 2015-11-16 18:55:10,002 DEBUG : BROWSER_OUTPUT: 18:55:10 INFO - 2015-11-16 18:55:10,002 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1051.52 Median:1051.52 stddev:0.00 (0.0%) 18:55:10 INFO - 2015-11-16 18:55:10,002 DEBUG : BROWSER_OUTPUT: Values: 1051.5 18:55:10 INFO - 2015-11-16 18:55:10,002 DEBUG : BROWSER_OUTPUT: 18:55:10 INFO - 2015-11-16 18:55:10,002 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:716.85 Median:716.85 stddev:0.00 (0.0%) 18:55:10 INFO - 2015-11-16 18:55:10,002 DEBUG : BROWSER_OUTPUT: Values: 716.8 18:55:10 INFO - 2015-11-16 18:55:10,003 DEBUG : BROWSER_OUTPUT: 18:55:10 INFO - 2015-11-16 18:55:10,003 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12228.92 Median:12228.92 stddev:0.00 (0.0%) 18:55:10 INFO - 2015-11-16 18:55:10,003 DEBUG : BROWSER_OUTPUT: Values: 12228.9 18:55:10 INFO - 2015-11-16 18:55:10,003 DEBUG : BROWSER_OUTPUT: 18:55:10 INFO - 2015-11-16 18:55:10,003 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24756.10 Median:24756.10 stddev:0.00 (0.0%) 18:55:10 INFO - 2015-11-16 18:55:10,003 DEBUG : BROWSER_OUTPUT: Values: 24756.1 18:55:10 INFO - 2015-11-16 18:55:10,003 DEBUG : BROWSER_OUTPUT: 18:55:10 INFO - 2015-11-16 18:55:10,003 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:749.44 Median:749.44 stddev:0.00 (0.0%) 18:55:10 INFO - 2015-11-16 18:55:10,003 DEBUG : BROWSER_OUTPUT: Values: 749.4 18:55:10 INFO - 2015-11-16 18:55:10,003 DEBUG : BROWSER_OUTPUT: 18:55:10 INFO - 2015-11-16 18:55:10,003 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 18:55:10 INFO - 2015-11-16 18:55:10,003 DEBUG : BROWSER_OUTPUT: Values: 4822.1 18:55:10 INFO - 2015-11-16 18:55:10,003 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:55:10 INFO - 2015-11-16 18:55:10,003 DEBUG : BROWSER_OUTPUT: 18:55:10 INFO - 2015-11-16 18:55:10,951 INFO : Browser exited with error code: 0 18:55:10 INFO - 2015-11-16 18:55:10,963 INFO : Completed test v8_7 (00:00:40) 18:55:11 INFO - 2015-11-16 18:55:11,006 INFO : Completed test suite (00:20:10) 18:55:11 INFO - 2015-11-16 18:55:11,006 DEBUG : Working with test: dromaeo_css 18:55:11 INFO - 2015-11-16 18:55:11,006 DEBUG : Generating results file: dromaeo_css 18:55:11 INFO - 2015-11-16 18:55:11,007 DEBUG : Working with test: kraken 18:55:11 INFO - 2015-11-16 18:55:11,007 DEBUG : Generating results file: kraken 18:55:11 INFO - 2015-11-16 18:55:11,008 INFO : javascript benchmark 18:55:11 INFO - 2015-11-16 18:55:11,008 DEBUG : Working with test: v8_7 18:55:11 INFO - 2015-11-16 18:55:11,008 DEBUG : Generating results file: v8_7 18:55:11 INFO - 2015-11-16 18:55:11,008 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:55:11 INFO - 2015-11-16 18:55:11,165 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 18:55:11 INFO - 2015-11-16 18:55:11,165 DEBUG : process_Request line: dromaeo_css 6970.86 graph.html#tests=[[72,1,43]] 18:55:11 INFO - 2015-11-16 18:55:11,165 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:55:11 INFO - 2015-11-16 18:55:11,197 DEBUG : process_Request line: kraken 1508.70 graph.html#tests=[[232,1,43]] 18:55:11 INFO - 2015-11-16 18:55:11,198 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:55:11 INFO - 2015-11-16 18:55:11,234 DEBUG : process_Request line: v8_7 20973.86 graph.html#tests=[[230,1,43]] 18:55:11 INFO - 2015-11-16 18:55:11,236 INFO : javascript benchmark 18:55:11 INFO - 2015-11-16 18:55:11,239 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [346.77806204029423, 350.2801742419328, 352.9823508824558, 354.1518064236154, 354.925465652213, 12522.436490357934, 12946.223226606411, 16460.753088703663, 17282.65434691307, 18570.53573660659, 10873.075788557962, 10905.563777448913, 11273.154513411506, 11852.585159519418, 12063.215890967082, 4588.4493860736675, 4680.227762419197, 4693.7653117344, 4695.976520117395, 4704.435467743859, 4867.756612169377, 4973.651844370896, 4978.825741099062, 5006.07387633289, 5008.0, 3489.616142224353, 3568.7858728476244, 4757.333973243749, 4958.181899986516, 4958.231474121517, 6582.934170658304, 6739.989001649743, 6755.898661520106, 6775.661216939158, 6784.423324017464, 6338.461230795388, 6472.838179045514, 6484.416402523795, 6514.153160089206, 6524.217093948757, 21005.789942100688, 22081.0, 22883.0, 23268.53462930732, 23501.059957601676, 2126.6278401279715, 2234.452559123009, 2261.09960318451, 2267.319804058776, 2284.4174735442357, 14177.220252886087, 14267.500637477639, 14436.422543098264, 14549.927250363786, 14944.0, 1951.7657881054222, 1974.5162435203467, 1981.8414526837819, 2008.457716416574, 2065.648839697255, 65842.67078664576, 69044.6547767263, 69126.0, 69415.65292173506, 69920.0, 15101.0, 15916.204189790697, 15953.760693589606, 16019.199040047952, 16039.839601604068, 24135.517289654108, 24149.879250603986, 24495.0, 24554.631680524806, 24642.260732178063, 9311.813763724824, 9327.626894924262, 9373.718788436357, 9457.479838608804, 9479.857802132974, 8004.119546849842, 8004.879926801103, 8008.919910800817, 8050.959745201237, 8061.6372263248295, 7682.846343073107, 7696.307332340116, 7746.922530774733, 7749.147593764681, 7750.7674769756995, 3214.51782232667, 3259.3155437357946, 3259.755518336134, 3278.7868788528667, 3315.8839440619463, 389.8869327894935, 397.45747055269925, 399.92201520703185, 400.65943947644854, 502.8466317773114, 9897.703068907944, 10070.59717611302, 10225.744356391, 10607.310524815863, 10880.455977201109, 400.37941191153595, 427.18194657231675, 436.73795722566206, 437.6783064447628, 439.51872699394113, 5861.20873682056, 5923.851903702442, 5962.85092872673, 5964.254468191476, 6019.819405417845, 514333.0, 521390.0, 533550.0, 534589.0, 544865.0, 77886.22113778903, 78059.60970195112, 78451.2154878444, 80129.0, 81388.18611813807, 456.80129143822546, 457.32544496866853, 457.4373520569718, 459.38213103375904, 462.4797103258834, 9890.752731181778, 10055.849162262426, 10075.697729068139, 10079.949600252245, 10184.847227291448, 33455.66544334526, 33845.153871153416, 34027.65972340245, 34694.30611387808, 35212.29575408426, 46745.0, 46787.35109983881, 47429.28856067231, 47443.76278118588, 48083.519164807905, 6835.179778426621, 6859.279775623488, 6886.001529778054, 6922.10012698346, 6927.445804335742, 12097.879021209676, 12466.43901024438, 12616.74766504683, 12626.873731262569, 12721.618351449471, 10872.402017889091, 10946.233763636468, 11066.225364224427, 11147.72130696739, 11173.888261117285, 10469.424181670081, 10844.566217351534, 11017.283876548, 11057.447127643747, 11066.391348475589, 10715.303505272132, 10766.300190487593, 10853.077488413257, 11138.832917506406, 11169.162312826407, 6514.9348506514325, 6970.860582788418, 7035.050268213726, 7037.366637002694, 7052.259512751088, 10898.78202435931, 11152.107831373633, 11156.888431115909, 11210.551577937118, 11294.435278235891], "dojo.html": [3275.6560561141064, 3298.9340213195733, 3310.222097807016, 3313.90058298251, 3350.296437748073, 5469.234307196985, 5644.153376993448, 5650.29371328584, 5687.601867869251, 5688.800891968782, 5495.148252020943, 5530.751116199771, 5560.193771903072, 5560.7219639017985, 5618.494335509803, 5056.342675452195, 5096.210087436453, 5185.170372740362, 5185.2999845021, 5232.764525596357, 5167.431582525919, 5168.250603662466, 5216.374035115772, 5228.633995620289, 5238.633295669305, 5009.674371165863, 5038.496150384969, 5109.974450127745, 5166.560842328407, 5185.662931909414, 5172.094883395391, 5180.507851754077, 5190.299309593194, 5197.298364720752, 5236.083685355085, 4997.450280469146, 5162.561182299509, 5164.535191832715, 5166.225066240057, 5167.4057483389515, 5302.893942121174, 5420.972895135538, 5452.482014208644, 5455.563554915637, 5464.836054918359, 6077.058056001327, 6113.083037544359, 6135.079738039285, 6135.233095863017, 6164.013757798775, 6094.39056094387, 6157.815265542041, 6161.260648722137, 6161.876762464725, 6177.104319873638, 5644.943550564483, 5707.200991861143, 5751.223584816038, 5763.94236057634, 5817.389174136655, 6204.13142160098, 6224.128621992924, 6248.843778905563, 6271.498280137578, 6281.842953926189, 6044.153818465418, 6047.2743270806905, 6051.425114614105, 6060.757295217397, 6105.9694701526205, 5954.0, 6003.429674180946, 6068.575199735976, 6068.696565171812, 6120.051392034242, 6047.0324748040985, 6153.876922461615, 6164.907526387108, 6165.0444181152, 6165.506759459233, 5922.970385148133, 6077.0, 6131.233595800525, 6131.356207598227, 6132.17215675878, 4581.496035436099, 4631.768411579407, 4653.069386122789, 4654.883627909329, 4675.158471475167, 4128.793560321972, 4132.607402296777, 4135.276326642826, 4141.275276826544, 4169.60388763067, 5830.82507524775, 5847.912281315784, 5848.912266316009, 5849.473547380756, 5893.469587737124, 5943.673097979567, 6021.397860213943, 6076.240469941257, 6104.732011601605, 6108.493847774667, 5833.095870140135, 5925.40745925404, 5927.0, 5944.851378715567, 5947.434993675594, 5109.054824857339, 5359.946400536022, 5364.436734142937, 5379.54273886724, 5385.030694474954, 6257.0, 6263.060540918898, 6472.255690595548, 6475.935240647627, 6490.707918143695, 6118.60229085108, 6126.479249263684, 6148.723307451265, 6152.107944347955, 6159.5072394209255, 6132.661461321697, 6224.657643829632, 6392.137061496638, 6396.872062558816, 6419.935800641933, 5910.379410161871, 5927.762889484372, 5958.702064896651, 5975.641461512323, 5995.790147344822, 6056.152138700498, 6060.757569697339, 6105.358937311518, 6131.417515336036, 6172.814815555541, 5825.94174058254, 5833.066709326487, 5917.497012753965, 5920.970395148169, 5958.7616495341435, 5956.404359564009, 5958.255218097738, 5968.0, 5977.0, 5978.372270911492, 5802.332731735904, 5810.854728631818, 5832.445917637818, 5834.445727655866, 5846.41535846429, 5771.192033115283, 5941.287045554561, 5947.613405128653, 5977.880442391215, 6120.60216085953, 5839.824805255849, 5861.7655293787775, 5880.705964701662, 5893.852653683521, 5900.085486749561], "mootools.html": [1513.9243037848105, 1682.2429906542056, 1728.6542691461702, 1732.0122788190365, 1762.4360204734483, 7546.1321947976, 7690.5770182639935, 7765.495242809214, 7783.1438541760435, 7906.130325664172, 7787.883181752279, 7800.453968222212, 7817.804554886116, 7887.645055972481, 7895.447318687694, 2112.2923820520105, 2129.0, 2138.187488754279, 2142.592907347607, 2166.967495487569, 2208.447888027993, 2248.4041728941843, 2272.318304508649, 2272.761360057195, 2283.292179424384, 2217.1796435318956, 2233.039792889057, 2257.164849005862, 2264.0264686184933, 2269.523400085984, 2222.9666555001686, 2224.9110035598555, 2239.4961133745023, 2252.0653928619604, 2252.977470225293, 2288.7482376938524, 2305.6080466320764, 2311.8266130040315, 2315.8378913476063, 2322.2800931711054, 7675.5010924289745, 7722.922770772277, 7736.265054819839, 7743.303102720783, 7752.496087754278, 4452.866414007585, 4457.799399027052, 4465.218586747306, 4489.102179564067, 4499.6400287976885, 2984.328526081636, 2984.820910745362, 3089.8609562569736, 3102.2089367211443, 3108.4404807134706, 1011.519528224095, 1023.7542989682497, 1027.8047171037479, 1030.8402197659375, 1047.8323468245044, 10480.371177729285, 10502.789944201073, 10508.2644214905, 10524.105451036594, 10579.682609521727, 3977.3238549446664, 3979.9403008954887, 4025.355943049098, 4035.394690796404, 4129.91740165195, 8651.6971905983, 8673.783155421164, 8685.696000639948, 8699.478031318142, 8705.12948705137, 4557.453105627346, 4566.56617621332, 4569.657275704269, 4579.908401832011, 4603.033362993809, 4179.749215047107, 4200.558941311179, 4203.0, 4234.618884300427, 4241.1941731071, 3416.9658303417145, 3423.8972830815114, 3433.4678124890684, 3434.433318502469, 3448.4654878493875, 1060.4379678770265, 1074.274864466482, 1077.9946100269449, 1092.7377429417043, 1103.3710784852717, 1067.8505009298703, 1078.9406582637873, 1149.9995004346272, 1238.5107882386408, 1335.8129861819352, 6927.445804335641, 7002.264762199896, 7010.298970102949, 7030.0, 7093.680784364716, 1133.880942501042, 1144.5192073034145, 1154.3362566524281, 1157.2767020612118, 1160.4313886195703, 5713.771449141987, 5762.2221000164445, 5764.827055188351, 5793.131030345482, 5806.0, 9039.18647321731, 9053.411528250643, 9158.86261706075, 9304.813903721888, 9336.766580835534, 9009.774755631162, 9120.680776172801, 9140.268778497704, 9148.359614827032, 9153.862692059625, 7144.535605185646, 7202.53183543068, 7240.348368646953, 7294.307040831112, 7310.597917114504, 7093.964530177316, 7148.857022859618, 7150.499465037606, 7202.675879585327, 7204.24355442671, 8011.437794538136, 8032.83934321322, 8218.58907054633, 8375.37184711137, 8391.16088391156, 8359.498430094214, 8374.162583741578, 8444.915550844413, 8481.448705834102, 8501.659933602834, 6875.209350924508, 7003.789886303419, 7006.789796306119, 7013.964930175316, 7020.087388639648, 7439.367653749492, 7464.813379665335, 7562.697492100255, 7571.432142589218, 7594.8101297468, 6959.4432445405255, 6982.615956122462, 7120.145582530129, 7269.382102521345, 7280.672369743268, 6938.5143039986715, 7056.717731290691, 7093.432525397852, 7133.072700548895, 7212.567245965259, 6987.161540615159, 7046.612436316052, 7149.857002860018, 7152.213256541672, 7152.356287934111, 6516.706748196248, 6527.967360163168, 6556.213254409501, 6556.3443655634055, 6559.901601475886, 6442.452391546583, 6501.642409667514, 6515.837104072247, 6529.477641788741, 6577.3422657735755], "ext.html": [559.7509108446743, 596.5585466754601, 603.2700432476704, 607.0772425912613, 608.4858294740948, 39218.60781392185, 40574.39138412926, 40729.18541629169, 40731.79634101826, 40869.59130408695, 43368.0, 44232.33651495222, 44342.556574434246, 44368.0, 44376.556234437645, 8921.866172007425, 9000.324975626821, 9080.636774529012, 9082.273418126568, 9086.545672716371, 8606.225439710424, 8689.826203475926, 8714.869276960851, 8742.912570874274, 8745.606447709837, 8817.470951742916, 8874.467531948072, 8896.733098007038, 8928.062553431893, 8950.41822281553, 8850.380473366868, 8921.509316987564, 8940.821183576358, 8944.776380590472, 8958.507282099481, 8825.602847871862, 8944.060873608243, 8950.060243674385, 8950.507722075283, 8959.5968181432, 40715.59284407148, 40841.18317633631, 41106.38340424896, 41209.175816483505, 41293.58706412927, 3403.710684591813, 3444.844981975817, 3456.1705190754287, 3565.750397472178, 3824.674902633252, 30335.0, 30564.541531876817, 30788.8460557698, 30794.230144246572, 30915.845420772977, 3415.692587667097, 3490.3891818931584, 3575.8390872410805, 3627.8004709740953, 3628.981855090734, 262541.0, 263470.68264658743, 263933.0, 264050.0, 265286.0, 61433.38566614366, 61583.38416615777, 61812.69093654503, 62105.0, 62167.37832621706, 60493.69753151206, 63234.36765632285, 64583.354166458674, 67673.6616316925, 67796.32203677998, 15158.498847690229, 15174.393024278905, 15196.088234705952, 15252.0, 15415.768763468557, 11628.709282268012, 11643.53425862956, 11671.824922626167, 11682.948534631754, 11728.824067638992, 20502.38492845217, 20964.79035209659, 21085.89457052705, 21093.472663183544, 21094.0, 7602.50583712057, 7788.844223115506, 7790.766277011699, 7814.882776758353, 7841.784523398882, 1022.5807418958192, 1054.372648274291, 1068.471106802138, 1071.1751950997689, 1088.0, 28331.858340708575, 28927.85536072306, 29363.55954660682, 29465.410691786044, 29489.557656635166, 1003.8745156855393, 1008.6671398438498, 1026.5329275179774, 1039.8336266197373, 1124.1400328748514, 13584.117032392864, 13683.657908552366, 13991.720165596631, 14022.649433764238, 14032.508862189978, 315963.0, 319785.0, 323030.0, 324673.0, 324852.0, 53617.46382536203, 53772.73113634407, 53797.1930421044, 53809.46190538123, 54089.72955135199, 1371.0882263294995, 1380.0477670407588, 1388.590365842079, 1393.1571399303275, 1394.135635905745, 25747.227583172535, 26696.733032669425, 26752.8662356687, 26953.59569606418, 27186.0, 45705.085898282516, 45738.77130614326, 45788.08423831438, 45902.31146532738, 45918.770406149095, 295565.0, 298118.0, 299452.0, 299549.0, 300144.0, 32004.5199322015, 32448.51327230046, 32563.18592035218, 32720.181995450304, 32739.34521309513, 40127.39808902927, 43475.0, 43901.78049109734, 44644.33033504435, 44950.0, 33781.0, 33831.49252761161, 33875.49186762151, 34065.82967085149, 34784.82607586946, 33939.830300848334, 34463.65536344604, 34705.479417809256, 36679.449808252364, 36879.0, 36293.63706362902, 36388.81805591061, 36516.087097821706, 36637.63362366342, 36653.0, 28749.28126796847, 29138.417231654825, 30799.384012320075, 30836.84581577078, 31049.223769405944, 24866.856004831963, 25204.621930671423, 25253.0, 25319.36701582475, 25320.0], "prototype.html": [301.168893129771, 302.92275469755214, 303.51740732235754, 307.6815495961679, 313.1654141712337, 6315.652639104847, 6328.525360597956, 6368.872622547547, 6468.256150542689, 6491.642959637218, 6278.874422511547, 6350.809475715736, 6380.744770209186, 6384.361563843613, 6397.552171347996, 4553.635709143261, 4646.4191976003, 4687.74217418041, 4695.718256904596, 4709.929351059737, 4631.467381251148, 4638.9536104638855, 4643.930341044887, 4682.812687492513, 4696.577308042276, 4623.976880115595, 4637.420322459692, 4638.420197475316, 4643.767811609423, 4644.349791029259, 4637.582617564419, 4650.232711602598, 4651.046535460239, 4662.650301227422, 4671.11248862715, 3832.386818109117, 3971.5631280559405, 3975.7216994810374, 3980.2835489611857, 3983.6098340995172, 5892.086726557391, 5974.0, 5988.7604495820115, 5997.370276121032, 6014.248218972629, 5385.919211211835, 5391.218273350381, 5394.7842086316505, 5394.865128371783, 5395.352557693062, 6644.4020038196795, 6686.465082793365, 6693.799186024427, 6693.866122677568, 6694.665266736643, 4263.275243208631, 4301.311790113598, 4348.108637729258, 4357.237483440385, 4370.322599997005, 6912.688928998207, 6995.125609298838, 6998.720051197997, 7000.9649951750425, 7005.019297298382, 4454.532274111171, 4464.129494748558, 4466.709663871838, 4476.0, 4488.5960263576435, 4536.6143877770755, 4539.0, 4545.545445455428, 4548.158590660738, 4557.134144512532, 5226.503482169188, 5415.620906536505, 5420.756065977041, 5428.70142142186, 5440.4287549807495, 6771.966140169267, 6782.457403407814, 6784.76253331131, 6796.898046529306, 6804.6257455840405, 1578.3528753211128, 1600.7678886561384, 1600.9439669611509, 1602.5993501624594, 1603.1663534961988, 1024.364893765855, 1026.8049070676698, 1042.2652030318607, 1046.6336782126348, 1047.0314958663207, 6558.934410655927, 6581.80254592363, 6589.9341006590275, 6598.406143447017, 6610.206775187008, 6912.44700423975, 6973.651317434108, 6976.7558135465015, 6994.33553812387, 7035.8241043973285, 6421.229452465734, 6480.222373315138, 6490.318516555788, 6560.639164845884, 6567.211934567882, 3809.809509524568, 3820.56063552695, 3822.8470861165797, 3832.9233415331537, 3835.0412396900774, 7249.275072492814, 7316.670749816271, 7422.851542969219, 7446.478746487802, 7476.925230747732, 7189.676464559107, 7277.417806575461, 7297.963510182415, 7337.26627337262, 7341.449391295674, 7237.819054523679, 7416.887466880011, 7443.590602516805, 7449.627518624047, 7464.962675186589, 7031.613261270679, 7070.7525236616475, 7071.82320441993, 7081.044059051962, 7090.6100164491445, 6936.237013928565, 6965.512414131165, 6971.65141742921, 6989.580625162506, 7029.26192749754, 7217.097862767154, 7329.596872172082, 7403.407727381689, 7428.665710042953, 7432.925670743223, 4522.366868638459, 4576.58810707038, 4584.426946631671, 4588.587027167571, 4598.3102534620075, 6956.443484521327, 6981.0924579804305, 6999.51003429755, 7005.474589405917, 7008.334208250208, 6645.734170633314, 6751.358620931003, 6759.0, 6782.457403407617, 6798.830029249309, 6755.1556055493065, 6774.390304872585, 6782.423494003065, 6782.830429239309, 6785.0, 6744.055832183596, 6753.696083676148, 6754.8649027020165, 6758.831029224112, 6768.898466523105, 6774.525783195129, 6856.485763567852, 6875.243723190345, 6880.105586273752, 6882.621455819978, 6632.0, 6691.2639609643875, 6692.464602831665, 6693.799186024427, 6701.128853249046], "yui.html": [780.8165081205916, 786.0331791895968, 787.2088551006237, 850.3069997951669, 867.20217399992, 14042.227677477747, 14218.644533886658, 14370.856291437109, 14372.928135359321, 14380.712385752291, 13703.794443083338, 13774.65563360914, 13787.207663003821, 13807.723845523084, 13814.79277810831, 815.2866242038232, 828.8176601147737, 834.8121672623672, 839.4459656626627, 839.7942504086508, 820.2003047029128, 821.6220538552274, 826.6610689617258, 829.3862541719145, 829.7427797382801, 860.0797147052656, 860.6514361683497, 861.1216559109704, 862.3704695572236, 864.8745931839879, 851.1786126388034, 855.2516548020482, 855.3029281135854, 856.7344123321728, 856.8629019356873, 628.4155735166294, 628.7956414165369, 630.2877748144567, 631.958922670025, 632.1529150937765, 13672.726545469035, 13768.862311376859, 13782.724345513034, 13812.37844297009, 13881.722365552632, 10052.0, 10366.999999999925, 10412.114970227463, 10534.947325263402, 11171.273867198606, 10082.24383171265, 10204.438755868425, 10222.539985700661, 10270.89729102707, 10332.586696532206, 3240.4815229563155, 3261.2010057535817, 3306.8677252909856, 3360.630330663625, 3390.0, 46396.768016160044, 46411.30383044257, 46487.302690459335, 46494.37269695578, 46523.0, 7872.606369681493, 7884.0, 7926.405519586054, 7946.523208607502, 7951.522908625501, 12250.754984900252, 12309.876901230873, 12353.876461235452, 12377.62867113988, 12413.44139513724, 6636.303188165173, 6849.349311815369, 6868.862622747517, 7047.295270472911, 7122.608256545836, 4284.078923031563, 4323.48118225815, 4449.221386257392, 4453.4433195850515, 4476.4180656514445, 2660.8536530490624, 2693.4074503609177, 2699.987504685743, 2716.2530304166116, 2717.320669832542, 433.9956600434018, 436.88204184870546, 440.9184300904279, 441.31596026159326, 443.81803460581006, 553.236533583652, 643.9092356687879, 654.9226522370768, 694.1947341084318, 694.9339812717784, 8075.111737708848, 8101.0, 8372.790680233044, 8778.692745753995, 8897.510636915033, 627.7771391156074, 691.339770519153, 712.8360477090298, 715.8174665460274, 729.923358047408, 4130.091379896418, 4180.435641188462, 4192.203481338536, 4207.558206388347, 4289.485261768607, 55563.0, 55609.1658625121, 57000.0, 57766.0, 57836.71081644565, 48718.5128148714, 49356.0, 50285.24572131421, 50312.99374012499, 50486.0, 45822.77088614602, 45974.77012614915, 46244.0, 46447.76776116165, 46606.300905486445, 8376.078631350425, 8863.290936725176, 8944.262556100542, 9031.096890310917, 9277.304202184729, 33608.0, 33996.49005264873, 34471.65528344785, 34618.82690586531, 35048.299034019685, 42008.57991420047, 42945.570544294154, 43347.34978975381, 43921.34117988169, 44819.103617926805, 8118.025836899374, 8371.288440482627, 8430.199131082538, 8529.616167272363, 8935.821283574422, 12109.878901210875, 12189.390530473618, 12212.755744884875, 12454.564090256797, 12687.238765674088, 10755.516001779783, 10858.511366988347, 10991.670249892515, 11040.0, 11578.594749183738, 10460.476976151314, 10628.096611788085, 10660.786784264426, 10685.412302323446, 10900.40047797347, 11401.315921044765, 11568.47941842636, 11961.820572691591, 12086.818697719365, 12110.333931633844, 9736.464494452874, 9837.458939758382, 9904.603815847286, 10093.339032415382, 10196.490175491344, 9143.77140571491, 9384.390014649027, 9846.852297215404, 9872.259580531345, 9878.703638890845]}, "summary": {"lowerIsBetter": false, "suite": 6970.858627726791, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 8141.4767554221, "unit": "ms", "value": 8141.4767554221}, "dojo.html": {"lowerIsBetter": false, "filtered": 5610.469786248989, "unit": "ms", "value": 5610.469786248989}, "mootools.html": {"lowerIsBetter": false, "filtered": 4448.01053944374, "unit": "ms", "value": 4448.01053944374}, "ext.html": {"lowerIsBetter": false, "filtered": 18621.891116607254, "unit": "ms", "value": 18621.891116607254}, "prototype.html": {"lowerIsBetter": false, "filtered": 4992.864506201722, "unit": "ms", "value": 4992.864506201722}, "yui.html": {"lowerIsBetter": false, "filtered": 6073.506242844798, "unit": "ms", "value": 6073.506242844798}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-018.e"}, "testrun": {"date": 1447727700, "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": "20151116163023", "branch": "Firefox", "revision": "ffe020f9145296f68d56866b01ffe1d35ac18b83"}}, {"talos_counters": {}, "results": {"audio-dft": [164.0, 160.0, 162.0, 162.0, 163.0, 164.0, 161.0, 159.0, 169.0, 165.0], "ai-astar": [111.0, 104.0, 113.0, 111.0, 110.0, 122.0, 110.0, 110.0, 110.0, 110.0], "imaging-gaussian-blur": [110.0, 109.0, 111.0, 110.0, 109.0, 111.0, 109.0, 110.0, 110.0, 110.0], "audio-beat-detection": [148.0, 126.0, 153.0, 164.0, 127.0, 153.0, 152.0, 127.0, 158.0, 125.0], "json-stringify-tinderbox": [68.0, 69.0, 69.0, 70.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0], "stanford-crypto-pbkdf2": [152.0, 152.0, 151.0, 148.0, 142.0, 155.0, 154.0, 153.0, 142.0, 149.0], "json-parse-financial": [61.0, 61.0, 61.0, 60.0, 61.0, 61.0, 60.0, 61.0, 66.0, 59.0], "stanford-crypto-sha256-iterative": [67.0, 68.0, 72.0, 66.0, 74.0, 68.0, 68.0, 67.0, 67.0, 66.0], "audio-fft": [72.0, 73.0, 72.0, 72.0, 72.0, 73.0, 145.0, 75.0, 72.0, 72.0], "imaging-darkroom": [149.0, 148.0, 147.0, 147.0, 145.0, 146.0, 146.0, 147.0, 146.0, 146.0], "stanford-crypto-ccm": [122.0, 128.0, 116.0, 129.0, 119.0, 129.0, 129.0, 116.0, 120.0, 117.0], "audio-oscillator": [90.0, 89.0, 135.0, 89.0, 90.0, 90.0, 129.0, 90.0, 90.0, 137.0], "stanford-crypto-aes": [85.0, 84.0, 92.0, 85.0, 86.0, 91.0, 84.0, 84.0, 83.0, 84.0], "imaging-desaturate": [96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 95.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1508.6999999999998, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 79.8, "unit": "ms", "value": 79.8}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 149.8, "unit": "ms", "value": 149.8}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 143.3, "unit": "ms", "value": 143.3}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 122.5, "unit": "ms", "value": 122.5}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 146.7, "unit": "ms", "value": 146.7}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 61.1, "unit": "ms", "value": 61.1}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 102.9, "unit": "ms", "value": 102.9}, "ai-astar": {"lowerIsBetter": true, "filtered": 111.1, "unit": "ms", "value": 111.1}, "audio-dft": {"lowerIsBetter": true, "filtered": 162.9, "unit": "ms", "value": 162.9}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 68.3, "unit": "ms", "value": 68.3}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 68.5, "unit": "ms", "value": 68.5}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.9, "unit": "ms", "value": 109.9}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.8, "unit": "ms", "value": 85.8}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.1, "unit": "ms", "value": 96.1}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-018.e"}, "testrun": {"date": 1447727700, "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": "20151116163023", "branch": "Firefox", "revision": "ffe020f9145296f68d56866b01ffe1d35ac18b83"}}, {"talos_counters": {}, "results": {"DeltaBlue": [193.7608990505716], "Encrypt": [282.9654782116582], "NavierStokes": [4822.115384615385], "Decrypt": [5050.50505050505], "Splay": [749.4390426327599], "Richards": [165.6451880072884], "RegExp": [24756.09756097561], "Earley": [716.8458781362007], "Boyer": [12228.915662650603], "RayTrace": [1051.5247108307046]}, "summary": {"lowerIsBetter": false, "suite": 20973.857897258793, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 341.234998, "unit": "score", "value": 341.234998}, "Encrypt": {"lowerIsBetter": false, "filtered": 940.6836540000003, "unit": "score", "value": 940.6836540000003}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.7487537387835, "unit": "score", "value": 307.7487537387835}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.70383799999996, "unit": "score", "value": 52.70383799999996}, "Splay": {"lowerIsBetter": false, "filtered": 108.73599500998002, "unit": "score", "value": 108.73599500998002}, "RegExp": {"lowerIsBetter": false, "filtered": 36.79840886699505, "unit": "score", "value": 36.79840886699505}, "Richards": {"lowerIsBetter": false, "filtered": 213.11817399999993, "unit": "score", "value": 213.11817399999993}, "Earley": {"lowerIsBetter": false, "filtered": 929.7158849999997, "unit": "score", "value": 929.7158849999997}, "Boyer": {"lowerIsBetter": false, "filtered": 54.498944827586165, "unit": "score", "value": 54.498944827586165}, "RayTrace": {"lowerIsBetter": false, "filtered": 703.7295389999999, "unit": "score", "value": 703.7295389999999}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-018.e"}, "testrun": {"date": 1447727700, "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": "20151116163023", "branch": "Firefox", "revision": "ffe020f9145296f68d56866b01ffe1d35ac18b83"}}] 18:55:11 INFO - RETURN: dromaeo_css: 6970.86 18:55:11 INFO - RETURN: kraken: 1508.70 18:55:11 INFO - RETURN: v8_7: 20973.86 18:55:11 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20973.86"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1508.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6970.86"}}} 18:55:11 INFO - Return code: 0 18:55:11 INFO - # TBPL SUCCESS # 18:55:11 INFO - Running post-action listener: _resource_record_post_action 18:55:11 INFO - Running post-run listener: _resource_record_post_run 18:55:12 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 712704; Write bytes: 274735104; Read time: 284; Write time: 299368 18:55:12 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 503808; Read time: 0; Write time: 40 18:55:12 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 712704; Write bytes: 270184448; Read time: 284; Write time: 298912 18:55:12 INFO - Running post-run listener: _upload_blobber_files 18:55:12 INFO - Blob upload gear active. 18:55:12 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:55:12 INFO - Copying logs to upload dir... 18:55:12 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1256.358081 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2015-11-16 18:55:12.429611) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 18:55:12.433222) ========= 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=6d5287d839824eebc594b0c9000001d1-1447727653.190162-1838257566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010095 build_url: 'https://queue.taskcluster.net/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 18:55:12.485338) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:55:12.485672) ========= 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=6d5287d839824eebc594b0c9000001d1-1447727653.190162-1838257566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:55:12.536269) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 18:55:12.536581) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 18:55:12.537166) ========= ========= Total master_lag: 0.17 =========