builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-010 starttime: 1448275713.45 results: success (0) buildid: 20151123013034 builduid: ebd4be6a341c485cb7c6db63bf183c20 revision: e722799fa71f653c31454612564c213d09566219 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 02:48:33.445788) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 02:48:33.446299) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 02:48:33.446622) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1448275443.503974-1928316655 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006437 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 02:48:33.477282) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 02:48:33.477545) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 02:48:33.493490) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 02:48:33.493776) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1448275443.503974-1928316655 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004700 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 02:48:33.546897) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 02:48:33.547266) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 02:48:33.547612) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 02:48:33.548001) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1448275443.503974-1928316655 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 02:48:34-- 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% 39.3M=0s 2015-11-23 02:48:34 (39.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.328345 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 02:48:33.889461) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 02:48:33.889841) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1448275443.503974-1928316655 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017544 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 02:48:33.939911) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 02:48:33.940272) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev e722799fa71f653c31454612564c213d09566219 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev e722799fa71f653c31454612564c213d09566219 --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=cbaddfaace6f82c7d20be4ba000001bb-1448275443.503974-1928316655 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 02:48:34,636 truncating revision to first 12 chars 2015-11-23 02:48:34,636 Setting DEBUG logging. 2015-11-23 02:48:34,636 attempt 1/10 2015-11-23 02:48:34,636 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/e722799fa71f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 02:48:34,906 unpacking tar archive at: mozilla-inbound-e722799fa71f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.532830 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 02:48:34.485749) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 02:48:34.486059) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 02:48:34.493641) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 02:48:34.493885) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 02:48:34.494261) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-11-23 02:48:34.494532) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=cbaddfaace6f82c7d20be4ba000001bb-1448275443.503974-1928316655 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:48:35 INFO - MultiFileLogger online at 20151123 02:48:35 in /builds/slave/test-pgo 02:48:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 02:48:35 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 02:48:35 INFO - {'append_to_log': False, 02:48:35 INFO - 'base_work_dir': '/builds/slave/test-pgo', 02:48:35 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 02:48:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 02:48:35 INFO - 'branch': 'Mozilla-Inbound', 02:48:35 INFO - 'buildbot_json_path': 'buildprops.json', 02:48:35 INFO - 'config_files': ('talos/linux_config.py',), 02:48:35 INFO - 'default_actions': ('clobber', 02:48:35 INFO - 'read-buildbot-config', 02:48:35 INFO - 'download-and-extract', 02:48:35 INFO - 'populate-webroot', 02:48:35 INFO - 'create-virtualenv', 02:48:35 INFO - 'install', 02:48:35 INFO - 'run-tests'), 02:48:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:48:35 INFO - 'download_minidump_stackwalk': True, 02:48:35 INFO - 'download_symbols': 'ondemand', 02:48:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:48:35 INFO - 'tooltool.py': '/tools/tooltool.py', 02:48:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:48:35 INFO - '/tools/misc-python/virtualenv.py')}, 02:48:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:48:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:48:35 INFO - 'installer_path': 'installer.exe', 02:48:35 INFO - 'log_level': 'info', 02:48:35 INFO - 'log_name': 'talos', 02:48:35 INFO - 'log_to_console': True, 02:48:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:48:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:48:35 INFO - 'opt_config_files': (), 02:48:35 INFO - 'pip_index': False, 02:48:35 INFO - 'sps_profile': False, 02:48:35 INFO - 'sps_profile_interval': 0, 02:48:35 INFO - 'suite': 'dromaeojs', 02:48:35 INFO - 'system_bits': '64', 02:48:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:48:35 INFO - 'title': 'talos-linux64-ix-010', 02:48:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:48:35 INFO - 'use_talos_json': True, 02:48:35 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 02:48:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:48:35 INFO - 'work_dir': 'build'} 02:48:35 INFO - ##### 02:48:35 INFO - ##### Running clobber step. 02:48:35 INFO - ##### 02:48:35 INFO - Running pre-action listener: _resource_record_pre_action 02:48:35 INFO - Running main action method: clobber 02:48:35 INFO - rmtree: /builds/slave/test-pgo/build 02:48:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 02:48:35 INFO - Running post-action listener: _resource_record_post_action 02:48:35 INFO - ##### 02:48:35 INFO - ##### Running read-buildbot-config step. 02:48:35 INFO - ##### 02:48:35 INFO - Running pre-action listener: _resource_record_pre_action 02:48:35 INFO - Running main action method: read_buildbot_config 02:48:35 INFO - Using buildbot properties: 02:48:35 INFO - { 02:48:35 INFO - "properties": { 02:48:35 INFO - "buildnumber": 474, 02:48:35 INFO - "product": "firefox", 02:48:35 INFO - "script_repo_revision": "production", 02:48:35 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 02:48:35 INFO - "repository": "", 02:48:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 02:48:35 INFO - "buildid": "20151123013034", 02:48:35 INFO - "slavename": "talos-linux64-ix-010", 02:48:35 INFO - "pgo_build": "True", 02:48:35 INFO - "basedir": "/builds/slave/test-pgo", 02:48:35 INFO - "project": "", 02:48:35 INFO - "platform": "ubuntu64_hw", 02:48:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:48:35 INFO - "slavebuilddir": "test", 02:48:35 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 02:48:35 INFO - "branch": "mozilla-inbound", 02:48:35 INFO - "repo_path": "integration/mozilla-inbound", 02:48:35 INFO - "stage_platform": "linux64-pgo", 02:48:35 INFO - "builduid": "ebd4be6a341c485cb7c6db63bf183c20", 02:48:35 INFO - "revision": "e722799fa71f653c31454612564c213d09566219" 02:48:35 INFO - }, 02:48:35 INFO - "sourcestamp": { 02:48:35 INFO - "repository": "", 02:48:35 INFO - "hasPatch": false, 02:48:35 INFO - "project": "", 02:48:35 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 02:48:35 INFO - "changes": [ 02:48:35 INFO - { 02:48:35 INFO - "category": null, 02:48:35 INFO - "files": [ 02:48:35 INFO - { 02:48:35 INFO - "url": null, 02:48:35 INFO - "name": "https://queue.taskcluster.net/v1/task/of9qwaCPTcaUZahEmOS9Ew/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 02:48:35 INFO - } 02:48:35 INFO - ], 02:48:35 INFO - "repository": "", 02:48:35 INFO - "rev": "e722799fa71f653c31454612564c213d09566219", 02:48:35 INFO - "who": "sendchange", 02:48:35 INFO - "when": 1448275704, 02:48:35 INFO - "number": 6694484, 02:48:35 INFO - "comments": "", 02:48:35 INFO - "project": "", 02:48:35 INFO - "at": "Mon 23 Nov 2015 02:48:24", 02:48:35 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 02:48:35 INFO - "revlink": "", 02:48:35 INFO - "properties": [ 02:48:35 INFO - [ 02:48:35 INFO - "buildid", 02:48:35 INFO - "20151123013034", 02:48:35 INFO - "Change" 02:48:35 INFO - ], 02:48:35 INFO - [ 02:48:35 INFO - "builduid", 02:48:35 INFO - "ebd4be6a341c485cb7c6db63bf183c20", 02:48:35 INFO - "Change" 02:48:35 INFO - ], 02:48:35 INFO - [ 02:48:35 INFO - "pgo_build", 02:48:35 INFO - "True", 02:48:35 INFO - "Change" 02:48:35 INFO - ] 02:48:35 INFO - ], 02:48:35 INFO - "revision": "e722799fa71f653c31454612564c213d09566219" 02:48:35 INFO - } 02:48:35 INFO - ], 02:48:35 INFO - "revision": "e722799fa71f653c31454612564c213d09566219" 02:48:35 INFO - } 02:48:35 INFO - } 02:48:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/of9qwaCPTcaUZahEmOS9Ew/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 02:48:35 INFO - Running post-action listener: _resource_record_post_action 02:48:35 INFO - ##### 02:48:35 INFO - ##### Running download-and-extract step. 02:48:35 INFO - ##### 02:48:35 INFO - Running pre-action listener: _resource_record_pre_action 02:48:35 INFO - Running main action method: download_and_extract 02:48:35 INFO - mkdir: /builds/slave/test-pgo/build/tests 02:48: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')]} 02:48:35 INFO - https://queue.taskcluster.net/v1/task/of9qwaCPTcaUZahEmOS9Ew/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:48:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/of9qwaCPTcaUZahEmOS9Ew/artifacts/public/build/test_packages.json 02:48:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/of9qwaCPTcaUZahEmOS9Ew/artifacts/public/build/test_packages.json 02:48:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/of9qwaCPTcaUZahEmOS9Ew/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 02:48:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/of9qwaCPTcaUZahEmOS9Ew/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 02:48:37 INFO - Downloaded 1302 bytes. 02:48:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 02:48:37 INFO - Using the following test package requirements: 02:48:37 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 02:48:37 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:48:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:48:37 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:48:37 INFO - u'jsshell-linux-x86_64.zip'], 02:48:37 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:48:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:48:37 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 02:48:37 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:48:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:48:37 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:48:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:48:37 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:48:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:48:37 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 02:48:37 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:48:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:48:37 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:48:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:37 INFO - https://queue.taskcluster.net/v1/task/of9qwaCPTcaUZahEmOS9Ew/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:48:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/of9qwaCPTcaUZahEmOS9Ew/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:48:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/of9qwaCPTcaUZahEmOS9Ew/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:48:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/of9qwaCPTcaUZahEmOS9Ew/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 02:48:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/of9qwaCPTcaUZahEmOS9Ew/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 02:48:39 INFO - Downloaded 22525380 bytes. 02:48:39 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 02:48:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:48:39 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 02:48:40 INFO - Return code: 0 02:48:40 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 02:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:40 INFO - https://queue.taskcluster.net/v1/task/of9qwaCPTcaUZahEmOS9Ew/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:48:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/of9qwaCPTcaUZahEmOS9Ew/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:48:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/of9qwaCPTcaUZahEmOS9Ew/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:48:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/of9qwaCPTcaUZahEmOS9Ew/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 02:48:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/of9qwaCPTcaUZahEmOS9Ew/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 02:48:53 INFO - Downloaded 22525380 bytes. 02:48:53 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 02:48:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:48:53 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 02:48:55 INFO - Return code: 0 02:48:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:55 INFO - https://queue.taskcluster.net/v1/task/of9qwaCPTcaUZahEmOS9Ew/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:48:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/of9qwaCPTcaUZahEmOS9Ew/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 02:48:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/of9qwaCPTcaUZahEmOS9Ew/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 02:48:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/of9qwaCPTcaUZahEmOS9Ew/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 02:48:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/of9qwaCPTcaUZahEmOS9Ew/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 02:48:56 INFO - Downloaded 11130997 bytes. 02:48:56 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 02:48:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 02:48:56 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 02:48:56 INFO - Return code: 0 02:48:56 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')]} 02:48:56 INFO - https://queue.taskcluster.net/v1/task/of9qwaCPTcaUZahEmOS9Ew/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:48:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/of9qwaCPTcaUZahEmOS9Ew/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:48:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/of9qwaCPTcaUZahEmOS9Ew/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:48:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/of9qwaCPTcaUZahEmOS9Ew/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 02:48:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/of9qwaCPTcaUZahEmOS9Ew/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 02:49:00 INFO - Downloaded 57544592 bytes. 02:49:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/of9qwaCPTcaUZahEmOS9Ew/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:49:00 INFO - mkdir: /builds/slave/test-pgo/properties 02:49:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 02:49:00 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 02:49:00 INFO - Contents: 02:49:00 INFO - build_url:https://queue.taskcluster.net/v1/task/of9qwaCPTcaUZahEmOS9Ew/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:49:00 INFO - Running post-action listener: _resource_record_post_action 02:49:00 INFO - Running post-action listener: set_extra_try_arguments 02:49:00 INFO - ##### 02:49:00 INFO - ##### Running populate-webroot step. 02:49:00 INFO - ##### 02:49:00 INFO - Running pre-action listener: _resource_record_pre_action 02:49:00 INFO - Running main action method: populate_webroot 02:49:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:49:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:49:00 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 02:49:00 INFO - '../fennec_ids.txt'], 02:49:00 INFO - 'tests': ['tcheck2']}, 02:49:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:49:00 INFO - '--tppagecycles', 02:49:00 INFO - '7'], 02:49:00 INFO - 'tests': ['tsvgm']}}, 02:49:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:49:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:49:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:49:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:49:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:49:00 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:49:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:49:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:49:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:49:00 INFO - 'talos_options': ['--e10s'], 02:49:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:49:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:49:00 INFO - 'tests': ['damp', 'tps']}, 02:49:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:49:00 INFO - 'talos_options': ['--e10s'], 02:49:00 INFO - 'tests': ['damp', 'tps']}, 02:49:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:49:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:49:00 INFO - 'other': {'tests': ['a11yr', 02:49:00 INFO - 'ts_paint', 02:49:00 INFO - 'tpaint', 02:49:00 INFO - 'sessionrestore', 02:49:00 INFO - 'sessionrestore_no_auto_restore']}, 02:49:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:49:00 INFO - 'tests': ['a11yr', 02:49:00 INFO - 'ts_paint', 02:49:00 INFO - 'tpaint', 02:49:00 INFO - 'sessionrestore', 02:49:00 INFO - 'sessionrestore_no_auto_restore']}, 02:49:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:49:00 INFO - 'tests': ['a11yr', 02:49:00 INFO - 'ts_paint', 02:49:00 INFO - 'tpaint', 02:49:00 INFO - 'sessionrestore', 02:49:00 INFO - 'sessionrestore_no_auto_restore']}, 02:49:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:49:00 INFO - 'tests': ['a11yr', 02:49:00 INFO - 'ts_paint', 02:49:00 INFO - 'tpaint', 02:49:00 INFO - 'sessionrestore', 02:49:00 INFO - 'sessionrestore_no_auto_restore']}, 02:49:00 INFO - 'other_l64': {'tests': ['a11yr', 02:49:00 INFO - 'ts_paint', 02:49:00 INFO - 'tpaint', 02:49:00 INFO - 'sessionrestore', 02:49:00 INFO - 'sessionrestore_no_auto_restore']}, 02:49:00 INFO - 'other_nol64': {'tests': ['a11yr', 02:49:00 INFO - 'ts_paint', 02:49:00 INFO - 'tpaint', 02:49:00 INFO - 'sessionrestore', 02:49:00 INFO - 'sessionrestore_no_auto_restore']}, 02:49:00 INFO - 'svgr': {'tests': ['tsvgx', 02:49:00 INFO - 'tsvgr_opacity', 02:49:00 INFO - 'tart', 02:49:00 INFO - 'tscrollx', 02:49:00 INFO - 'cart']}, 02:49:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:49:00 INFO - 'tests': ['tsvgx', 02:49:00 INFO - 'tsvgr_opacity', 02:49:00 INFO - 'tart', 02:49:00 INFO - 'tscrollx', 02:49:00 INFO - 'cart']}, 02:49:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:49:00 INFO - 'tests': ['tp5o']}, 02:49:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:49:00 INFO - 'talos_options': ['--e10s'], 02:49:00 INFO - 'tests': ['tp5o']}, 02:49:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:49:00 INFO - 'talos_options': ['--xperf_path', 02:49:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:49:00 INFO - 'tests': ['tp5n']}, 02:49:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:49:00 INFO - 'talos_options': ['--e10s', 02:49:00 INFO - '--xperf_path', 02:49:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:49:00 INFO - 'tests': ['tp5n']}}, 02:49:00 INFO - 'talos.zip': {'path': '', 02:49:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:49:00 INFO - Running post-action listener: _resource_record_post_action 02:49:00 INFO - ##### 02:49:00 INFO - ##### Running create-virtualenv step. 02:49:00 INFO - ##### 02:49:00 INFO - Running pre-action listener: _resource_record_pre_action 02:49:00 INFO - Running main action method: create_virtualenv 02:49:00 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 02:49:00 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 02:49:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 02:49:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:49:00 INFO - Using real prefix '/usr' 02:49:00 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 02:49:01 INFO - Installing distribute.............................................................................................................................................................................................done. 02:49:03 INFO - Installing pip.................done. 02:49:03 INFO - Return code: 0 02:49:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 02:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:03 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 0x7f93e58b0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b47c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f8d70>, '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 0x16f9b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f9fb0>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1448275443.503974-1928316655', '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 02:49:03 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 02:49:03 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 02:49:03 INFO - Using env: {'DISPLAY': ':0', 02:49:03 INFO - 'HOME': '/home/cltbld', 02:49:03 INFO - 'LANG': 'en_US.UTF-8', 02:49:03 INFO - 'LANGUAGE': 'en_US:en', 02:49:03 INFO - 'LOGNAME': 'cltbld', 02:49:03 INFO - 'MAIL': '/var/mail/cltbld', 02:49:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:03 INFO - 'MOZ_NO_REMOTE': '1', 02:49:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:49:03 INFO - 'NO_EM_RESTART': '1', 02:49:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:49:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:49:03 INFO - 'PWD': '/builds/slave/test-pgo', 02:49:03 INFO - 'SHELL': '/bin/bash', 02:49:03 INFO - 'SHLVL': '1', 02:49:03 INFO - 'TERM': 'linux', 02:49:03 INFO - 'TMOUT': '86400', 02:49:03 INFO - 'USER': 'cltbld', 02:49:03 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1448275443.503974-1928316655', 02:49:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:03 INFO - '_': '/tools/buildbot/bin/python'} 02:49:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:03 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 02:49:03 INFO - Cleaning up... 02:49:03 INFO - Return code: 0 02:49:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 02:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:03 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 0x7f93e58b0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b47c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f8d70>, '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 0x16f9b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f9fb0>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1448275443.503974-1928316655', '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 02:49:03 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 02:49:03 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 02:49:03 INFO - Using env: {'DISPLAY': ':0', 02:49:03 INFO - 'HOME': '/home/cltbld', 02:49:03 INFO - 'LANG': 'en_US.UTF-8', 02:49:03 INFO - 'LANGUAGE': 'en_US:en', 02:49:03 INFO - 'LOGNAME': 'cltbld', 02:49:03 INFO - 'MAIL': '/var/mail/cltbld', 02:49:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:03 INFO - 'MOZ_NO_REMOTE': '1', 02:49:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:49:03 INFO - 'NO_EM_RESTART': '1', 02:49:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:49:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:49:03 INFO - 'PWD': '/builds/slave/test-pgo', 02:49:03 INFO - 'SHELL': '/bin/bash', 02:49:03 INFO - 'SHLVL': '1', 02:49:03 INFO - 'TERM': 'linux', 02:49:03 INFO - 'TMOUT': '86400', 02:49:03 INFO - 'USER': 'cltbld', 02:49:03 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1448275443.503974-1928316655', 02:49:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:03 INFO - '_': '/tools/buildbot/bin/python'} 02:49:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:03 INFO - Downloading/unpacking psutil>=0.7.1 02:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:05 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 02:49:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:49:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 02:49:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:49:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:49:05 INFO - Installing collected packages: psutil 02:49:05 INFO - Running setup.py install for psutil 02:49:05 INFO - building 'psutil._psutil_linux' extension 02:49:05 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 02:49:05 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 02:49:05 INFO - building 'psutil._psutil_posix' extension 02:49:05 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 02:49:05 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 02:49:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:49:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:49:05 INFO - Successfully installed psutil 02:49:05 INFO - Cleaning up... 02:49:06 INFO - Return code: 0 02:49:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 02:49:06 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')]} 02:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:06 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')]} 02:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:06 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 0x7f93e58b0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b47c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f8d70>, '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 0x16f9b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f9fb0>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1448275443.503974-1928316655', '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 02:49:06 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 02:49:06 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 02:49:06 INFO - Using env: {'DISPLAY': ':0', 02:49:06 INFO - 'HOME': '/home/cltbld', 02:49:06 INFO - 'LANG': 'en_US.UTF-8', 02:49:06 INFO - 'LANGUAGE': 'en_US:en', 02:49:06 INFO - 'LOGNAME': 'cltbld', 02:49:06 INFO - 'MAIL': '/var/mail/cltbld', 02:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:06 INFO - 'MOZ_NO_REMOTE': '1', 02:49:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:49:06 INFO - 'NO_EM_RESTART': '1', 02:49:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:49:06 INFO - 'PWD': '/builds/slave/test-pgo', 02:49:06 INFO - 'SHELL': '/bin/bash', 02:49:06 INFO - 'SHLVL': '1', 02:49:06 INFO - 'TERM': 'linux', 02:49:06 INFO - 'TMOUT': '86400', 02:49:06 INFO - 'USER': 'cltbld', 02:49:06 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1448275443.503974-1928316655', 02:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:06 INFO - '_': '/tools/buildbot/bin/python'} 02:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:49:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:49:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:49:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:49:07 INFO - Installing collected packages: mozsystemmonitor 02:49:07 INFO - Running setup.py install for mozsystemmonitor 02:49:08 INFO - Successfully installed mozsystemmonitor 02:49:08 INFO - Cleaning up... 02:49:08 INFO - Return code: 0 02:49:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 02:49:08 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')]} 02:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:08 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')]} 02:49:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:08 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 0x7f93e58b0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b47c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f8d70>, '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 0x16f9b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f9fb0>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1448275443.503974-1928316655', '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 02:49:08 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 02:49:08 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 02:49:08 INFO - Using env: {'DISPLAY': ':0', 02:49:08 INFO - 'HOME': '/home/cltbld', 02:49:08 INFO - 'LANG': 'en_US.UTF-8', 02:49:08 INFO - 'LANGUAGE': 'en_US:en', 02:49:08 INFO - 'LOGNAME': 'cltbld', 02:49:08 INFO - 'MAIL': '/var/mail/cltbld', 02:49:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:08 INFO - 'MOZ_NO_REMOTE': '1', 02:49:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:49:08 INFO - 'NO_EM_RESTART': '1', 02:49:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:49:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:49:08 INFO - 'PWD': '/builds/slave/test-pgo', 02:49:08 INFO - 'SHELL': '/bin/bash', 02:49:08 INFO - 'SHLVL': '1', 02:49:08 INFO - 'TERM': 'linux', 02:49:08 INFO - 'TMOUT': '86400', 02:49:08 INFO - 'USER': 'cltbld', 02:49:08 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1448275443.503974-1928316655', 02:49:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:08 INFO - '_': '/tools/buildbot/bin/python'} 02:49:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:08 INFO - Downloading/unpacking blobuploader==1.2.4 02:49:08 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 02:49:08 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 02:49:08 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 02:49:08 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 02:49:08 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 02:49:08 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 02:49:09 INFO - Downloading blobuploader-1.2.4.tar.gz 02:49:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:49:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:49:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:49:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 02:49:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:10 INFO - Downloading docopt-0.6.1.tar.gz 02:49:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:49:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 02:49:10 INFO - Installing collected packages: blobuploader, requests, docopt 02:49:10 INFO - Running setup.py install for blobuploader 02:49:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:49:10 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 02:49:10 INFO - Running setup.py install for requests 02:49:11 INFO - Running setup.py install for docopt 02:49:11 INFO - Successfully installed blobuploader requests docopt 02:49:11 INFO - Cleaning up... 02:49:11 INFO - Return code: 0 02:49:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:49:11 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')]} 02:49:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:11 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')]} 02:49:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:11 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 0x7f93e58b0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b47c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f8d70>, '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 0x16f9b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f9fb0>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1448275443.503974-1928316655', '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 02:49:11 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 02:49:11 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 02:49:11 INFO - Using env: {'DISPLAY': ':0', 02:49:11 INFO - 'HOME': '/home/cltbld', 02:49:11 INFO - 'LANG': 'en_US.UTF-8', 02:49:11 INFO - 'LANGUAGE': 'en_US:en', 02:49:11 INFO - 'LOGNAME': 'cltbld', 02:49:11 INFO - 'MAIL': '/var/mail/cltbld', 02:49:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:11 INFO - 'MOZ_NO_REMOTE': '1', 02:49:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:49:11 INFO - 'NO_EM_RESTART': '1', 02:49:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:49:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:49:11 INFO - 'PWD': '/builds/slave/test-pgo', 02:49:11 INFO - 'SHELL': '/bin/bash', 02:49:11 INFO - 'SHLVL': '1', 02:49:11 INFO - 'TERM': 'linux', 02:49:11 INFO - 'TMOUT': '86400', 02:49:11 INFO - 'USER': 'cltbld', 02:49:11 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1448275443.503974-1928316655', 02:49:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:11 INFO - '_': '/tools/buildbot/bin/python'} 02:49:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:49:11 INFO - Running setup.py (path:/tmp/pip-ZM3uSz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:49:11 INFO - Running setup.py (path:/tmp/pip-IJBlH6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:49:11 INFO - Running setup.py (path:/tmp/pip-lWH16s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:49:11 INFO - Running setup.py (path:/tmp/pip-mYwrno-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:49:11 INFO - Running setup.py (path:/tmp/pip-hGxk2g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:49:11 INFO - Running setup.py (path:/tmp/pip-GknIXU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:49:11 INFO - Running setup.py (path:/tmp/pip-3nkNcL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:49:12 INFO - Running setup.py (path:/tmp/pip-7wz9ZH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:49:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:49:12 INFO - Running setup.py (path:/tmp/pip-CaS37_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:49:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:49:12 INFO - Running setup.py (path:/tmp/pip-YlVKrq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:49:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:49:12 INFO - Running setup.py (path:/tmp/pip-qAbnc8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:49:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:49:12 INFO - Running setup.py (path:/tmp/pip-z3sw3B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:49:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:49:12 INFO - Running setup.py (path:/tmp/pip-lVTMdm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:49:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:49:12 INFO - Running setup.py (path:/tmp/pip-j29X4E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:49:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:49:12 INFO - Running setup.py (path:/tmp/pip-QSTZPN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:49:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:49:12 INFO - Running setup.py (path:/tmp/pip-eMQArl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:49:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:49:12 INFO - Running setup.py (path:/tmp/pip-4FMnGc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:49:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:49:12 INFO - Running setup.py install for manifestparser 02:49:12 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 02:49:12 INFO - Running setup.py install for mozcrash 02:49:12 INFO - Running setup.py install for mozdebug 02:49:13 INFO - Running setup.py install for mozdevice 02:49:13 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 02:49:13 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 02:49:13 INFO - Running setup.py install for mozfile 02:49:13 INFO - Running setup.py install for mozhttpd 02:49:13 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 02:49:13 INFO - Running setup.py install for mozinfo 02:49:13 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 02:49:13 INFO - Running setup.py install for mozInstall 02:49:13 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 02:49:13 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 02:49:13 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 02:49:13 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 02:49:13 INFO - Running setup.py install for mozleak 02:49:13 INFO - Running setup.py install for mozlog 02:49:13 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 02:49:13 INFO - Running setup.py install for moznetwork 02:49:13 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 02:49:13 INFO - Running setup.py install for mozprocess 02:49:13 INFO - Running setup.py install for mozprofile 02:49:14 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 02:49:14 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 02:49:14 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 02:49:14 INFO - Running setup.py install for mozrunner 02:49:14 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 02:49:14 INFO - Running setup.py install for mozscreenshot 02:49:14 INFO - Running setup.py install for moztest 02:49:14 INFO - Running setup.py install for mozversion 02:49:14 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 02:49:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:49:14 INFO - Cleaning up... 02:49:14 INFO - Return code: 0 02:49:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:49:14 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')]} 02:49:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:14 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')]} 02:49:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:14 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 0x7f93e58b0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b47c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f8d70>, '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 0x16f9b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f9fb0>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1448275443.503974-1928316655', '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 02:49:14 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 02:49:14 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 02:49:14 INFO - Using env: {'DISPLAY': ':0', 02:49:14 INFO - 'HOME': '/home/cltbld', 02:49:14 INFO - 'LANG': 'en_US.UTF-8', 02:49:14 INFO - 'LANGUAGE': 'en_US:en', 02:49:14 INFO - 'LOGNAME': 'cltbld', 02:49:14 INFO - 'MAIL': '/var/mail/cltbld', 02:49:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:14 INFO - 'MOZ_NO_REMOTE': '1', 02:49:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:49:14 INFO - 'NO_EM_RESTART': '1', 02:49:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:49:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:49:14 INFO - 'PWD': '/builds/slave/test-pgo', 02:49:14 INFO - 'SHELL': '/bin/bash', 02:49:14 INFO - 'SHLVL': '1', 02:49:14 INFO - 'TERM': 'linux', 02:49:14 INFO - 'TMOUT': '86400', 02:49:14 INFO - 'USER': 'cltbld', 02:49:14 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1448275443.503974-1928316655', 02:49:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:14 INFO - '_': '/tools/buildbot/bin/python'} 02:49:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:49:15 INFO - Running setup.py (path:/tmp/pip-JH5QXl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:49:15 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)) 02:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:49:15 INFO - Running setup.py (path:/tmp/pip-wbK5am-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:49:15 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)) 02:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:49:15 INFO - Running setup.py (path:/tmp/pip-jwCiIj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:49:15 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)) 02:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:49:15 INFO - Running setup.py (path:/tmp/pip-pksP9l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:49:15 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)) 02:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:49:15 INFO - Running setup.py (path:/tmp/pip-oum7jL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:49:15 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)) 02:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:49:15 INFO - Running setup.py (path:/tmp/pip-sTD_lt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:49:15 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)) 02:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:49:15 INFO - Running setup.py (path:/tmp/pip-3QT6iw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:49:15 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)) 02:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:49:15 INFO - Running setup.py (path:/tmp/pip-9iCded-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:49:15 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)) 02:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:49:15 INFO - Running setup.py (path:/tmp/pip-rkjy63-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:49:15 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)) 02:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:49:15 INFO - Running setup.py (path:/tmp/pip-AUBGX4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 02:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:49:15 INFO - Running setup.py (path:/tmp/pip-7kKPh5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:49:15 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)) 02:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:49:15 INFO - Running setup.py (path:/tmp/pip-VBfSSi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:49:15 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)) 02:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:49:15 INFO - Running setup.py (path:/tmp/pip-QyV8AH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:49:16 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)) 02:49:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:49:16 INFO - Running setup.py (path:/tmp/pip-u_h555-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:49:16 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)) 02:49:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:49:16 INFO - Running setup.py (path:/tmp/pip-MLYsl6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:49:16 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)) 02:49:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:49:16 INFO - Running setup.py (path:/tmp/pip-WYmPM0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:49:16 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)) 02:49:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:49:16 INFO - Running setup.py (path:/tmp/pip-LjcL8V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:49:16 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)) 02:49:16 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)) 02:49:16 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)) 02:49:16 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)) 02:49:16 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)) 02:49:16 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)) 02:49:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 02:49:16 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 02:49:16 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 02:49:16 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 02:49:16 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 02:49:16 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 02:49:16 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 02:49:17 INFO - Downloading blessings-1.5.1.tar.gz 02:49:17 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 02:49:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 02:49:18 INFO - Installing collected packages: blessings 02:49:18 INFO - Running setup.py install for blessings 02:49:18 INFO - Successfully installed blessings 02:49:18 INFO - Cleaning up... 02:49:18 INFO - Return code: 0 02:49:18 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 02:49:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:49:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:49:18 INFO - Reading from file tmpfile_stdout 02:49:18 INFO - Current package versions: 02:49:18 INFO - argparse == 1.2.1 02:49:18 INFO - blessings == 1.5.1 02:49:18 INFO - blobuploader == 1.2.4 02:49:18 INFO - docopt == 0.6.1 02:49:18 INFO - manifestparser == 1.1 02:49:18 INFO - mozInstall == 1.12 02:49:18 INFO - mozcrash == 0.16 02:49:18 INFO - mozdebug == 0.1 02:49:18 INFO - mozdevice == 0.47 02:49:18 INFO - mozfile == 1.2 02:49:18 INFO - mozhttpd == 0.7 02:49:18 INFO - mozinfo == 0.9 02:49:18 INFO - mozleak == 0.1 02:49:18 INFO - mozlog == 3.1 02:49:18 INFO - moznetwork == 0.27 02:49:18 INFO - mozprocess == 0.22 02:49:18 INFO - mozprofile == 0.27 02:49:18 INFO - mozrunner == 6.11 02:49:18 INFO - mozscreenshot == 0.1 02:49:18 INFO - mozsystemmonitor == 0.0 02:49:18 INFO - moztest == 0.7 02:49:18 INFO - mozversion == 1.4 02:49:18 INFO - psutil == 3.1.1 02:49:18 INFO - requests == 1.2.3 02:49:18 INFO - wsgiref == 0.1.2 02:49:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:49:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f93e58b0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b47c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f8d70>, '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 0x16f9b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f9fb0>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1448275443.503974-1928316655', '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 02:49:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 02:49:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 02:49:18 INFO - Using env: {'DISPLAY': ':0', 02:49:18 INFO - 'HOME': '/home/cltbld', 02:49:18 INFO - 'LANG': 'en_US.UTF-8', 02:49:18 INFO - 'LANGUAGE': 'en_US:en', 02:49:18 INFO - 'LOGNAME': 'cltbld', 02:49:18 INFO - 'MAIL': '/var/mail/cltbld', 02:49:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:18 INFO - 'MOZ_NO_REMOTE': '1', 02:49:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:49:18 INFO - 'NO_EM_RESTART': '1', 02:49:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:49:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:49:18 INFO - 'PWD': '/builds/slave/test-pgo', 02:49:18 INFO - 'SHELL': '/bin/bash', 02:49:18 INFO - 'SHLVL': '1', 02:49:18 INFO - 'TERM': 'linux', 02:49:18 INFO - 'TMOUT': '86400', 02:49:18 INFO - 'USER': 'cltbld', 02:49:18 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1448275443.503974-1928316655', 02:49:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:18 INFO - '_': '/tools/buildbot/bin/python'} 02:49:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:18 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)) 02:49:18 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)) 02:49:18 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)) 02:49:18 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)) 02:49:18 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)) 02:49:18 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)) 02:49:18 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)) 02:49:18 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)) 02:49:18 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)) 02:49:18 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)) 02:49:18 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)) 02:49:18 INFO - Cleaning up... 02:49:18 INFO - Return code: 0 02:49:18 INFO - Running post-action listener: _resource_record_post_action 02:49:18 INFO - Running post-action listener: _start_resource_monitoring 02:49:18 INFO - Starting resource monitoring. 02:49:18 INFO - ##### 02:49:18 INFO - ##### Running install step. 02:49:18 INFO - ##### 02:49:18 INFO - Running pre-action listener: _resource_record_pre_action 02:49:18 INFO - Running main action method: install 02:49:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:49:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:49:18 INFO - Reading from file tmpfile_stdout 02:49:18 INFO - Detecting whether we're running mozinstall >=1.0... 02:49:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 02:49:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 02:49:18 INFO - Reading from file tmpfile_stdout 02:49:18 INFO - Output received: 02:49:18 INFO - Usage: mozinstall [options] installer 02:49:18 INFO - Options: 02:49:18 INFO - -h, --help show this help message and exit 02:49:18 INFO - -d DEST, --destination=DEST 02:49:18 INFO - Directory to install application into. [default: 02:49:18 INFO - "/builds/slave/test-pgo"] 02:49:18 INFO - --app=APP Application being installed. [default: firefox] 02:49:18 INFO - mkdir: /builds/slave/test-pgo/build/application 02:49:18 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'] 02:49:18 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 02:49:33 INFO - Reading from file tmpfile_stdout 02:49:33 INFO - Output received: 02:49:33 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 02:49:33 INFO - Running post-action listener: _resource_record_post_action 02:49:33 INFO - ##### 02:49:33 INFO - ##### Running run-tests step. 02:49:33 INFO - ##### 02:49:33 INFO - Running pre-action listener: _resource_record_pre_action 02:49:33 INFO - Running main action method: run_tests 02:49:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 02:49:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 02:49:33 INFO - Python 2.7.3 02:49:33 INFO - Return code: 0 02:49:33 INFO - grabbing minidump binary from tooltool 02:49:33 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')]} 02:49:33 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 0x16f8d70>, '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 0x16f9b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f9fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 02:49:33 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 02:49:33 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 02:49:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:49:33 INFO - Return code: 0 02:49:33 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 02:49:33 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 02:49:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 02:49:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 02:49:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 02:49:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/of9qwaCPTcaUZahEmOS9Ew/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 02:49:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/of9qwaCPTcaUZahEmOS9Ew/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost 02:49:33 INFO - Using env: {'DISPLAY': ':0', 02:49:33 INFO - 'HOME': '/home/cltbld', 02:49:33 INFO - 'LANG': 'en_US.UTF-8', 02:49:33 INFO - 'LANGUAGE': 'en_US:en', 02:49:33 INFO - 'LOGNAME': 'cltbld', 02:49:33 INFO - 'MAIL': '/var/mail/cltbld', 02:49:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:49:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 02:49:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:33 INFO - 'MOZ_NO_REMOTE': '1', 02:49:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:49:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:49:33 INFO - 'NO_EM_RESTART': '1', 02:49:33 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:49:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:49:33 INFO - 'PWD': '/builds/slave/test-pgo', 02:49:33 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 02:49:33 INFO - 'SHELL': '/bin/bash', 02:49:33 INFO - 'SHLVL': '1', 02:49:33 INFO - 'TERM': 'linux', 02:49:33 INFO - 'TMOUT': '86400', 02:49:33 INFO - 'USER': 'cltbld', 02:49:33 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1448275443.503974-1928316655', 02:49:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:33 INFO - '_': '/tools/buildbot/bin/python'} 02:49:33 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/of9qwaCPTcaUZahEmOS9Ew/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost'] with output_timeout 3600 02:49:33 INFO - mozversion INFO | application_buildid: 20151123013034 02:49:33 INFO - mozversion INFO | application_changeset: e722799fa71f653c31454612564c213d09566219 02:49:33 INFO - mozversion INFO | application_display_name: Nightly 02:49:33 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:49:33 INFO - mozversion INFO | application_name: Firefox 02:49:33 INFO - mozversion INFO | application_remotingname: firefox 02:49:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:49:33 INFO - mozversion INFO | application_vendor: Mozilla 02:49:33 INFO - mozversion INFO | application_version: 45.0a1 02:49:33 INFO - mozversion INFO | platform_buildid: 20151123013034 02:49:33 INFO - mozversion INFO | platform_changeset: e722799fa71f653c31454612564c213d09566219 02:49:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:49:33 INFO - mozversion INFO | platform_version: 45.0a1 02:49:33 INFO - 2015-11-23 02:49:33,713 DEBUG : using testdate: 1448275773 02:49:33 INFO - 2015-11-23 02:49:33,713 DEBUG : actual date: 1448275773 02:49:33 INFO - 2015-11-23 02:49:33,761 INFO : starting webserver on 'localhost:33393' 02:49:33 INFO - 2015-11-23 02:49:33,762 INFO : Starting test suite talos-linux64-ix-010 02:49:33 INFO - 2015-11-23 02:49:33,762 INFO : Starting test dromaeo_css 02:49:33 INFO - 2015-11-23 02:49:33,762 DEBUG : operating with platform_type : linux_ 02:49:33 INFO - 2015-11-23 02:49:33,763 INFO : Initialising browser for dromaeo_css test... 02:49:33 INFO - 2015-11-23 02:49:33,777 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpR9d_xn/profile http://localhost:33393/getInfo.html 02:49:38 INFO - 2015-11-23 02:49:38,039 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:49:38 INFO - 2015-11-23 02:49:38,039 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:49:38 INFO - 2015-11-23 02:49:38,040 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:49:38 INFO - 2015-11-23 02:49:38,040 DEBUG : BROWSER_OUTPUT: __metrics 02:49:38 INFO - 2015-11-23 02:49:38,156 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:49:39 INFO - 2015-11-23 02:49:39,497 INFO : Browser initialized. 02:49:39 INFO - 2015-11-23 02:49:39,498 INFO : Running cycle 1/1 for dromaeo_css test... 02:49:39 INFO - 2015-11-23 02:49:39,498 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpR9d_xn/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:49:51 INFO - 2015-11-23 02:49:51,307 DEBUG : BROWSER_OUTPUT: RSS: Main: 140079104 02:49:51 INFO - 2015-11-23 02:49:51,307 DEBUG : BROWSER_OUTPUT: 02:50:42 INFO - 2015-11-23 02:50:42,919 DEBUG : BROWSER_OUTPUT: 1448275842915 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] 02:52:51 INFO - 2015-11-23 02:52:51,616 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33393/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33393/tests/dromaeo/cssquery-ext.html) 02:52:52 INFO - 2015-11-23 02:52:52,786 DEBUG : BROWSER_OUTPUT: RSS: Main: 255520768 02:52:52 INFO - 2015-11-23 02:52:52,786 DEBUG : BROWSER_OUTPUT: 02:55:55 INFO - 2015-11-23 02:55:55,181 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33393/tests/dromaeo/cssquery-ext.html (next: http://localhost:33393/tests/dromaeo/cssquery-jquery.html) 02:55:55 INFO - 2015-11-23 02:55:55,755 DEBUG : BROWSER_OUTPUT: RSS: Main: 225345536 02:55:55 INFO - 2015-11-23 02:55:55,755 DEBUG : BROWSER_OUTPUT: 02:58:57 INFO - 2015-11-23 02:58:57,760 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33393/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33393/tests/dromaeo/cssquery-mootools.html) 02:58:58 INFO - 2015-11-23 02:58:58,325 DEBUG : BROWSER_OUTPUT: RSS: Main: 218558464 02:58:58 INFO - 2015-11-23 02:58:58,326 DEBUG : BROWSER_OUTPUT: 03:02:00 INFO - 2015-11-23 03:02:00,190 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33393/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33393/tests/dromaeo/cssquery-prototype.html) 03:02:00 INFO - 2015-11-23 03:02:00,759 DEBUG : BROWSER_OUTPUT: RSS: Main: 200548352 03:02:00 INFO - 2015-11-23 03:02:00,759 DEBUG : BROWSER_OUTPUT: 03:05:03 INFO - 2015-11-23 03:05:03,151 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33393/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33393/tests/dromaeo/cssquery-yui.html) 03:05:03 INFO - 2015-11-23 03:05:03,759 DEBUG : BROWSER_OUTPUT: RSS: Main: 202768384 03:05:03 INFO - 2015-11-23 03:05:03,759 DEBUG : BROWSER_OUTPUT: 03:08:06 INFO - 2015-11-23 03:08:06,599 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33393/tests/dromaeo/cssquery-yui.html (next: http://localhost:33393/tests/dromaeo/cssquery-dojo.html) 03:08:06 INFO - 2015-11-23 03:08:06,849 DEBUG : BROWSER_OUTPUT: RSS: Main: 237371392 03:08:06 INFO - 2015-11-23 03:08:06,849 DEBUG : BROWSER_OUTPUT: 03:08:06 INFO - 2015-11-23 03:08:06,850 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:08:06 INFO - 2015-11-23 03:08:06,850 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:08:06 INFO - 2015-11-23 03:08:06,851 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:08:06 INFO - 2015-11-23 03:08:06,851 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:08:06 INFO - 2015-11-23 03:08:06,851 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3178.5391118287844;3245.204924793426;3292.588426446694;3297.1757060734817;3318.021183750793;5344.278522399475;5427.837164885055;5447.373552041517;5466.398696143426;5478.315210598676;5382.650127741694;5433.293671822667;5433.701146436954;5493.862653433656;5516.9172462413;4882.170031094723;4888.217885138379;4901.779419926094;4967.726775027372;5069.467705890884;5052.242163675442;5067.493250674921;5098.464661210575;5103.948960510403;5122.590192784568;4829.565339119478;4832.951670483285;4921.950780492203;4942.283368911523;4956.983818317236;5006.649534532584;5013.022460620181;5015.272785446126;5020.77406516704;5068.949310506885;4954.777035033432;5002.899942001176;5003.4996500350035;5028.748562571894;5074.238864170367;5076.796928122871;5283.181106928432;5293.814716484904;5395.433479484676;5435.592330575183;5901.586888917777;5945.851353716149;5946.43508866657;5960.97019514904;5965.433283838029;5704.515116215127;5930.080837470199;5935.080062590306;5939.227900372967;5942.257217847769;5317.707526086064;5359.035373632783;5416.647917885403;5476.0416927038;5509.283793106871;6039.607425517327;6043.54673399488;6053.828449898408;6055.6063855849225;6109.938900611026;5519.199716041232;5815.098659707752;5819.127130930309;5823.126531020296;5881.852953676193;5813.476787089182;5909.054551271776;5969;5969.373215812364;6026.337102918676;5921.259842519685;5940.910886336708;5955.225820643289;5963.940360596339;5974.492168165668;5777.624454410534;5921.911171332434;5946.345901950782;5962.5826192167;5966.254218222723;4417.3815665806815;4421.7789110544345;4435.423394958635;4445.755483448376;4505.211587972091;4037.5760545142925;4067.2272268269526;4068.6745060395097;4113.938290925638;4117.053077792125;5663.858403539862;5677.687727174963;5682.261306030189;5683.062294721325;5683.147527870852;5770.942290577124;5829.271341082364;5863.618864773776;5870.119482077637;6021.337652858182;5635.1828984796975;5662.348829884533;5669.6314739541795;5671.716414179275;5672.602917795797;5226;5232.555232805178;5233.241180028875;5233.398159211663;5272.209168624737;5950.613210141327;6088.786892458743;6100.359462256488;6105.542084343692;6173.69131543412;5924.822255332347;6023.1868697726995;6029.728662210124;6031.4270144336215;6036.154938308552;6191.690415479298;6227;6246.906296405648;6249.78125765596;6250.406211409909;5706.600537962303;5741.74162162712;5832.183494310885;5833.1250312451775;5930.406959304035;5946.73239704223;5954.702264886651;5989.341172470938;5996.70016499182;6003.489703375262;5762.740676669476;5764.279465066867;5766.5675074368755;5798.1302804579655;5812.82561523155;5600.691961942132;5690.630109042899;5691.573132015198;5772.422757724194;5779.479846813807;5454.536364409069;5515.4760297771645;5524.779008839601;5565.860853478695;5591.245181900392;5739.942600573941;5747.367789543064;5781.046127388934;5783.913241301468;5809.186713859978;5510.421405752499;5618.2134501170685;5704.172894930295;5711;5718.771249150153 03:08:06 INFO - 2015-11-23 03:08:06,854 DEBUG : BROWSER_OUTPUT: |1;ext.html;575.7380391921674;577.0997244298894;577.1198921644494;582.1616871704745;593.8782549577337;30746.84626576867;39341;39823.80088099563;39941.60058399415;40034;42899.211551249144;43347.3497897531;43447.78276108615;43530.347044794355;43562;7587.962060189691;7707.07515098189;8672.653093876237;8835.293176545862;8849.646014159425;10457.58169673212;10695.625653102143;10699.197560182978;10699.411532365717;10706.41114738689;10417.895821041768;10509.369437833717;10536.894631053707;10538.104261137813;10540.47297635119;7774.02824646922;7952.721654742114;10136.391816491034;10315.277930544866;10379.377237365745;9929.652462163862;9955.402675839472;10015.69952901414;10016.499175041292;10065.849012264749;35407.645923540695;35456;35655.4651680225;35812.104697382514;35857.820710896536;3189.7607679423904;3221.742260619145;3387.4072037393357;3673.81630918453;4136.193442278757;29457.263568410748;29578;29938.101856944108;30258;30983.845080774678;3918.294706952747;3947.822347994347;4018.417329487208;4101.774402407867;4230.936535951963;267332;268717;269423;269757;269880;57416.42583574111;58631;59790.70104649536;66484;67524.32475675279;61142;61762;61789.910504474596;62082;62132.378676213564;15630.374785008473;15858.60353491172;15880.20598970047;15880.52358429249;15881.205939702968;12006.21959572625;12070.094742894318;12071.215371000857;12075.09436792244;12233.510659573518;20037.699434508493;20226.19095236174;20300;20305.593888122155;20307.28924487636;7981.48120372174;8009.599520023976;8181.71364002269;8234.752957411287;8247.268073704588;900.9459432434074;953.2135987810084;1016.9237307201989;1079.3308148947704;1079.6922876980022;27831.860840695666;27866.44267114687;32225.194370140933;32862;32937.67062329394;1009.2329829329616;1009.6365308488938;1011.3173607814696;1023.9385636861812;1077.498962982217;14019.579412617637;14215.928920355333;14252.216128113054;14364.856351436561;14544.200068996306;368636;372961;373376.13311933266;373768;373771;51738;52471.475285246655;52500.212496811815;52605.7369713149;52606.73696631492;1342.214804339453;1351.770199066161;1363.4614327340646;1365.3582816076428;1367.8153449284218;24991.625125623494;31564.842175788974;31984.560694768326;32283.35433291368;32356.514652280704;46077.76961115173;46737.53262467332;46753.2987005202;46762;46802;308010;310149;310769;311009;311186;31955.201119972186;45789.542104578526;45790.31314530218;46171.76914115408;46963.765181173876;43417.78291108524;43478.347824782024;43491;43745.562544375425;44438.55561444473;36443.45334820033;36653.26693466169;37540.2491950154;37543.62456375401;37811.62188378081;31985.680143199203;36612.81693591515;37233.25533489369;37372;39562.80218598888;36580.26839463143;36651.08372290714;36768;36789.632103679694;37647.81176094212;31698.366032678758;31756.523652144773;33812.4667498642;34220.657793422746;34233.65766342404;25474.23577292684;25692.357691057874;26080.73919260783;26505;27951.34462226085 03:08:06 INFO - 2015-11-23 03:08:06,856 DEBUG : BROWSER_OUTPUT: |2;jquery.html;358.9892303230904;359.6026390838124;359.92621512589903;360.1069348016917;360.6123417326375;14217.075890067139;14380.352884120213;16374.754378684314;16671;17384.391546295883;14102.64743381416;14643.707125857476;16486.83513164868;16843.90514616549;16950.3219871205;5432.864178395552;5638.126090455966;5643;5644.943550564503;5650.152477128443;3876.8255428505786;3971.7021223408215;5371.892562148755;5510.090835012218;5547.417521160281;5931.555133365015;6052.092186172065;6086.17836592061;6086.360932102132;6094.238220222473;5914.260717410302;6038.064100064497;6041.214642096521;6073.483753880925;6082.908756368658;5347.786088556453;5347.893042139135;5358.839234822962;5359.624826262163;5362.168863826074;19477.31829385979;19705.408837734893;19713.310034148737;20131.39605811828;20228;2204.481946742514;2332.976670233293;2394.078279862248;2410.3130607776698;2518.4585314157544;13104.172995801582;13494.797578036338;13499.86500134996;13628.454861805516;13736.381862816197;1775.9112044397857;1881.1628825172804;1884.7172924061501;1919.0980239287512;1929.556202073531;57933.42066579322;59891.40108598902;60008;60370.39629603692;61390.693046534485;9605.18355939739;9712.951435242778;9855.11303982645;9948.950255248677;9957;13153.802692959613;13187.296604196117;13192.20846749198;13197.53808616713;13200.20798752078;7377.077865266841;7399.260073992557;7419.183889772121;7436.888446673304;7478.214787447239;7265.527740696838;7316.597587132653;7458.4033277337685;7508.474406791582;7526.02161718973;5862.237909071793;5979.880402391927;5992.40075992406;6041.577089603774;6073.271207455045;1666.983330166707;1687.4684474390529;1708.325211541434;1740.1895938059943;1761.4979730776668;419.9517055538591;420.97474151551006;433.5252898076601;965.8937516873139;1012.1649639047815;9710.563024663767;9940.204783617293;10050.145737612385;10067.395956242648;10276.177905767521;400.4353861055897;400.6592126947779;400.88173988672827;402.9637332640018;435.17099924643605;5364.463553644604;5597.944020559824;5627.493525582635;5663.414244011683;5679.545636349082;369834;373309;374963;376301;402291;75541;76227.61886190645;78000.21999780044;80944.59527702324;81966.59016704997;1139.3904261220373;1153.8211577205548;1186.821976703484;1189.7739429508538;1191.2495128069434;13941.093828901088;14583.270836457923;14871.256437178314;15306.23468826532;15546.689066218838;32834.50748238826;33082.17294567655;33338;33391.1652208687;35637.64362356343;43844.78077609719;44737;45261.32108018448;45661.77169114133;46009.77931544893;8954.417962832395;9324.300677449082;9378.5779639915;9421.246300296098;9434.29242806806;10919.39943303126;13395.330233488092;16609.916950415172;16895.577610559834;16971.830281697024;10340.510151474116;11556.479958401724;11867.109966752356;13852.515161969282;14390.280485975869;13407.597772066854;13652.795208071688;13868.098573592684;14064.929675351557;14174.503892363718;12762.42569084412;13728.450861965808;13989.510367137102;14218.431262749375;14322.355494002586;8975.192232699088;9031.322650801085;9147.542622868963;9175.908240917772;9215.815683686424;10059.044390782863;10155.796884062425;11650.88349116532;14457;14997.475088371855 03:08:06 INFO - 2015-11-23 03:08:06,857 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1353.4045020191109;1465.6848777512835;1536.7848501209828;1666.5083800278917;1778.1287169287045;6511.446527045201;7154.35610795029;7401.925980740198;7403.62981850908;7409.333160015598;7231.963840180805;7248.383887369567;7291.343779059884;7293.7082516699265;7298.343149116578;1934.3906669399164;1970.3202395173641;2159.600473912323;2172.598069357174;2175.760666326703;2172.728408948881;2246.9101235950625;2249.572581209573;2250.2799104286637;2251.8536295140843;2124.2352753008904;2163.491579478821;2168.577127460146;2169.1865550418593;2169.3166652504488;1926.5472613935715;1966.5378636020453;1967.1442922328833;1968.8523360748002;2161.221960094365;2187.147012665062;2237.2505210754416;2241.3388050525136;2242.988785056081;2243.4839986802963;7186.820329491752;7326.853462930765;7327.9267207327775;7330.633468326562;7333.156686981012;4401.207782599131;4474.105178964221;4510.0979804039325;4511.954880451219;4511.977440112812;2963.7036296370406;2996.5654980027994;2998.595189649391;2999.4151140527606;3000.2799328161304;978.3933960944261;980.2990861533966;1002.4286156890576;1006.1397505133152;1039.7608550033458;9622.903770962272;9625.229981601455;9633.421994680342;9638.132568068837;9683.90316096837;3992.540857801332;4023.8591649292134;4071.368937814584;4075.1645912587846;4084.346504559256;8378;8404.789880253042;8410.537420441811;8413.915860841313;8432.198941100585;4534.093181363674;4548.113117942035;4575.679702420799;4576.519465456146;4581.404417425713;4093.8771836844944;4098.426220329156;4100.2414553307135;4101.179764047202;4101.938470922939;3546.4148415511154;3550.5029295898594;3555;3588.2823435313044;3622.927541449209;1196.7785959597502;1200.687821166503;1211.249025604131;1222.9816552751715;1236.2150034727833;1078.1428764132534;1137.2664631312757;1340.9396577154052;1380.1167252958114;1381.4681347681214;7039.54242974205;7081.575105493584;7089;7094.858102838018;7106.786796396116;439.73396095362483;455.45345585297116;456.3907183909518;457.3071796228716;460.4796579864731;5318.069337865858;5387.0841956867425;5433.728313584384;5553.333599968029;5849.093390524476;8530.957345213359;8759.386842921062;8876.112388761072;8928.15182557656;8937.910620893837;8359.205875441823;8664.350173736995;8670.306375489945;8784.516851573097;8791.34064945119;6634.336566343423;6643.069970204176;6667.533272670867;6684.766033188815;6715.39561439463;6889.689963951534;6956.756513522205;6967.198772141066;6995;7015.6842942066705;7109.431245500451;7589;7851.05787305527;7859.646315915912;7897.4076944230565;7794.415418843723;7862.095858976291;7927;8003.19968003195;8177.67289308421;6876.793696189123;6942.132233470817;6954.408875245661;6955.408790252885;6969.1985421677155;6861.1080559526945;7078.327558881898;7149.7497587584185;7168.677409516688;7188.5327453715345;6604.5046621502615;6697.665116744241;6723.5293529452465;6735.966320168368;6841.726330946706;6547.836304092245;6622.569532980341;6628.5691430056895;6638.734450621921;6741.662916854236;6447.774327898689;6538.378854008862;6548.541602087998;6567.802965911031;6590.176227971504;6244.875102498016;6257.78097766576;6261.68691565429;6263.185785847811;6266.655333956676;6229.813105606839;6240.375962403905;6246.750129994749;6246.781362652286;6329.90505142414 03:08:06 INFO - 2015-11-23 03:08:06,857 DEBUG : BROWSER_OUTPUT: |4;prototype.html;325.1027165024532;327.0874260812334;327.6608709985166;334.17958910873824;336.91577105723576;5929.703514824258;5931.080682494209;5972.641641501513;5986.982213023785;5989.3112292086425;5628.296462942132;5707.600467967244;5798.188253644493;5899.380565040673;5902.881942361161;4571.725696458207;4575.565321294472;4587;4591.678582499209;4602.907941841161;4302.182585308781;4584.17484852728;4585.128825523157;4587.908241835161;4588.288815233627;4340.52254252032;4409.933850992237;4531.7960691768785;4545.227311357061;4556.316552517133;4513.526079761644;4514.142312960527;4523.525029871866;4525.524819893897;4541;3981.1042515433796;3985.123272879962;3987.2424239394422;3992.241474119937;3999.42008408782;5530.557555395599;5623.409541998113;5624.6625202487985;5626.043572592669;5628.971855140739;5253.133233016548;5306.204069389584;5308.469153084699;5315.574754019669;5317.8936421271355;6198.194234749454;6224.066390041485;6252.531060170505;6261.749530018794;6263.1544741459775;4445.355423463612;4448.221561226805;4452.710573812724;4457.064016556495;4458.063806600618;6316.210473690789;6440.5491615586925;6474.708638111297;6477.83805404864;6488.188976377953;4537.6143027843;4537.909241815211;4545.545445455428;4548.431446069241;4553.931691024637;4594.839180628662;4598;4602.470715867718;4610.746408947473;4616.376789133424;5273.235380869829;5277.815276465382;5279.498447647467;5285;5296.602754793406;6098.817035488943;6259.217597800275;6298.7795427160745;6308.842278943063;6312.810615681537;1554;1587.8332775058452;1588.356715530212;1588.610790356347;1589.4913627639276;1047.512906498482;1057.27048336649;1061.2783307351076;1063.2132222155549;1083.247143235444;6047.667378294148;6053.970824959767;6054.636721796706;6057.454829065406;6067.24159480065;6438.163038804925;6447.967760161263;6448.226212854487;6455.160829092282;6483.222013358333;5932.5550583705535;6038.5772995889865;6041.154238406627;6044.24446944132;6049.304330002018;3434.4676575130893;3496.4056110461283;3505.1237190702323;3507.035565219534;3513.4554144107706;6664.100346453264;6676.26561078281;6737.191537015589;6753.3921947025;6765.898511522331;6511.674416279167;6678.699458524378;6679.131712877295;6680;6685.231198412148;6753.898691519631;6759.493038022168;6764.8985265222045;6765.255821859591;6771.187457505131;6496.512761542808;6502.284748677736;6504.577202481823;6508.316626754312;6515.087887695821;6282.623042617458;6431.260405053479;6438.163038804925;6441.67791610427;6446.709898054505;6757.493188011017;6759.357861003196;6760.290169532325;6762.695678694372;6768.763093291711;4477.910441791081;4478.059607482465;4480.484744254452;4485.686001979961;4488.4165058543485;6303.716332764945;6431.581947173606;6450.225972883284;6451.322611125952;6464.321246269262;6305.5270854687;6317.526185536195;6337.334579869047;6340.795248902694;6345.0482427636225;6258.374162583706;6286.339934306832;6293.244810622755;6295.937040629535;6311.463525600376;6080.48315893154;6188.721507532082;6212.006079027515;6226.159468471879;6237.313895471585;6350.872982540416;6354.618722876642;6361.236651601837;6383;6383.042543618309;6217.502599792097;6229.283632382153;6231.9688401557705;6253.3121356651645;6257.78097766576 03:08:06 INFO - 2015-11-23 03:08:06,858 DEBUG : BROWSER_OUTPUT: |5;yui.html;783.2911215350108;846.9534175620338;864.8486514859906;867.3798234262503;869.7651634058808;13915.930420347897;14237.85762142377;14238.145711257332;14254.287285635728;14265.928670356647;10826.025657690807;13217.678232176802;13300.667483312922;13329.200247985127;13335.53325633603;670.684778154268;809.8096947217399;821.5522540215567;824.4146655874337;825.4799476329904;821.4003777242616;821.5768879027306;827.3091968206555;828.2752591482453;828.883956246126;710.4742490557003;719.9460040496957;859.2910848549972;866.1901122450497;866.9609867555976;832.3466079127886;859.2181115185183;860.7761981884723;860.832137733136;861.0743450790362;632.7405763636887;635.7552342348183;637.3976592120448;639.5842702243532;639.7153266796278;13355.666108347272;13446.991475639366;13540.458381664721;13557.457701691921;13568.118072325366;12230.327331996737;12594.937025314906;12806.743865122646;12812;12981.091323607352;10436.686899393031;10437.895621043768;10450.634227801991;10483.213758968108;10638.148948084212;3617;3624.130208749881;3669.94495082574;3708.8145592720257;3737.4789966245203;45993.31010034852;46028;46418;46472.53527464716;47255.746982771714;10028.69913902584;10061.949690251502;10095.697129086138;10198.286119971532;10292.279540432248;18061.367852125113;18077.09614519269;18184.36354727578;18213;18240.63518729618;7391.2978267064545;7610.961945190239;7615.619219039026;7618.200088990576;7674;4291.54938731435;4436.689431739812;4455.75493347869;4493.752843593568;4613.0543238636;3041.467743144985;3079.2148002259282;3086.382723455318;3086.9504368514813;3088.6139232595924;542.4521233554138;549.0419218463727;554.6866020698293;559.580314763927;559.960802743804;524.6851888866726;535.0155713487202;655.0730716036754;656.8719099775593;674.305465370669;7922.7227047053075;8296.253337199681;8312.33501319893;8385.119562445856;8431.494110353398;603.2670305578743;611.2420598457969;612.935641757618;633.6246095448978;647.1231481342807;3766.1761701406754;3961.267165574378;3972.6226008529143;4043;4079.551249362568;57566.7121664389;58301;58555;58723;58894.116588251214;51575.742121289906;52046.47953520492;52429;52479;52679;45745.31382029272;46464.76767616208;46685.06629867384;47088.999999999316;47458.28812567814;8249.917500824915;8285.83428331442;8401.789955250923;8616.310695144499;8659.220670139717;35020.64979350276;35692;36123.81938090398;36174.8191259042;36394.27211455809;42616.14767704691;42675.3598696026;46540.53459465497;46876.531234687216;46906;10032.347897386646;10091.848622270818;10257.487125643836;10367.740806479898;10890.61882834097;10614.89385106139;10674.46627668598;10811.6215932442;10851.240413171317;11061.225714199929;10365.792684146125;10603.787924241626;10847;10928.289661172317;10932.344059356465;10173.491325433846;10383.896161038292;10503.422311772925;10847.67456976292;10851.891481085087;9765.755856103655;10246.6413675521;10324.122449591869;10369.688909332732;10557.20820938448;8647.956760216159;8685.088065753005;8755.562221889008;8857.291416686521;8984.59569319369;8391.790205244917;8588.699395521127;8868.423552469068;9176.311776616914;9204.677836275698 03:08:06 INFO - 2015-11-23 03:08:06,858 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:08:06 INFO - 2015-11-23 03:08:06,859 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:08:06 INFO - 2015-11-23 03:08:06,859 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,990 03:08:06 INFO - 2015-11-23 03:08:06,859 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:08:06 INFO - 2015-11-23 03:08:06,859 DEBUG : BROWSER_OUTPUT: __startTimestamp1448276886849__endTimestamp 03:08:06 INFO - 2015-11-23 03:08:06,859 DEBUG : BROWSER_OUTPUT: 03:08:06 INFO - 2015-11-23 03:08:06,859 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:08:06 INFO - 2015-11-23 03:08:06,859 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:08:06 INFO - 2015-11-23 03:08:06,859 DEBUG : BROWSER_OUTPUT: 03:08:06 INFO - 2015-11-23 03:08:06,860 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5479.76 Median:5683.06 stddev:625.36 (11.0%) stddev-sans-first:600.66 03:08:06 INFO - 2015-11-23 03:08:06,860 DEBUG : BROWSER_OUTPUT: Values: 3178.5 3245.2 3292.6 3297.2 3318.0 5344.3 5427.8 5447.4 5466.4 5478.3 5382.7 5433.3 5433.7 5493.9 5516.9 4882.2 4888.2 4901.8 4967.7 5069.5 5052.2 5067.5 5098.5 5103.9 5122.6 4829.6 4833.0 4922.0 4942.3 4957.0 5006.6 5013.0 5015.3 5020.8 5068.9 4954.8 5002.9 5003.5 5028.7 5074.2 5076.8 5283.2 5293.8 5395.4 5435.6 5901.6 5945.9 5946.4 5961.0 5965.4 5704.5 5930.1 5935.1 5939.2 5942.3 5317.7 5359.0 5416.6 5476.0 5509.3 6039.6 6043.5 6053.8 6055.6 6109.9 5519.2 5815.1 5819.1 5823.1 5881.9 5813.5 5909.1 5969.0 5969.4 6026.3 5921.3 5940.9 5955.2 5963.9 5974.5 5777.6 5921.9 5946.3 5962.6 5966.3 4417.4 4421.8 4435.4 4445.8 4505.2 4037.6 4067.2 4068.7 4113.9 4117.1 5663.9 5677.7 5682.3 5683.1 5683.1 5770.9 5829.3 5863.6 5870.1 6021.3 5635.2 5662.3 5669.6 5671.7 5672.6 5226.0 5232.6 5233.2 5233.4 5272.2 5950.6 6088.8 6100.4 6105.5 6173.7 5924.8 6023.2 6029.7 6031.4 6036.2 6191.7 6227.0 6246.9 6249.8 6250.4 5706.6 5741.7 5832.2 5833.1 5930.4 5946.7 5954.7 5989.3 5996.7 6003.5 5762.7 5764.3 5766.6 5798.1 5812.8 5600.7 5690.6 5691.6 5772.4 5779.5 5454.5 5515.5 5524.8 5565.9 5591.2 5739.9 5747.4 5781.0 5783.9 5809.2 5510.4 5618.2 5704.2 5711.0 5718.8 03:08:06 INFO - 2015-11-23 03:08:06,860 DEBUG : BROWSER_OUTPUT: 03:08:06 INFO - 2015-11-23 03:08:06,860 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49193.85 Median:35431.82 stddev:83824.12 (236.6%) stddev-sans-first:83979.79 03:08:06 INFO - 2015-11-23 03:08:06,860 DEBUG : BROWSER_OUTPUT: Values: 575.7 577.1 577.1 582.2 593.9 30746.8 39341.0 39823.8 39941.6 40034.0 42899.2 43347.3 43447.8 43530.3 43562.0 7588.0 7707.1 8672.7 8835.3 8849.6 10457.6 10695.6 10699.2 10699.4 10706.4 10417.9 10509.4 10536.9 10538.1 10540.5 7774.0 7952.7 10136.4 10315.3 10379.4 9929.7 9955.4 10015.7 10016.5 10065.8 35407.6 35456.0 35655.5 35812.1 35857.8 3189.8 3221.7 3387.4 3673.8 4136.2 29457.3 29578.0 29938.1 30258.0 30983.8 3918.3 3947.8 4018.4 4101.8 4230.9 267332.0 268717.0 269423.0 269757.0 269880.0 57416.4 58631.0 59790.7 66484.0 67524.3 61142.0 61762.0 61789.9 62082.0 62132.4 15630.4 15858.6 15880.2 15880.5 15881.2 12006.2 12070.1 12071.2 12075.1 12233.5 20037.7 20226.2 20300.0 20305.6 20307.3 7981.5 8009.6 8181.7 8234.8 8247.3 900.9 953.2 1016.9 1079.3 1079.7 27831.9 27866.4 32225.2 32862.0 32937.7 1009.2 1009.6 1011.3 1023.9 1077.5 14019.6 14215.9 14252.2 14364.9 14544.2 368636.0 372961.0 373376.1 373768.0 373771.0 51738.0 52471.5 52500.2 52605.7 52606.7 1342.2 1351.8 1363.5 1365.4 1367.8 24991.6 31564.8 31984.6 32283.4 32356.5 46077.8 46737.5 46753.3 46762.0 46802.0 308010.0 310149.0 310769.0 311009.0 311186.0 31955.2 45789.5 45790.3 46171.8 46963.8 43417.8 43478.3 43491.0 43745.6 44438.6 36443.5 36653.3 37540.2 37543.6 37811.6 31985.7 36612.8 37233.3 37372.0 39562.8 36580.3 36651.1 36768.0 36789.6 37647.8 31698.4 31756.5 33812.5 34220.7 34233.7 25474.2 25692.4 26080.7 26505.0 27951.3 03:08:06 INFO - 2015-11-23 03:08:06,860 DEBUG : BROWSER_OUTPUT: 03:08:06 INFO - 2015-11-23 03:08:06,860 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23830.63 Median:374136.00 stddev:62453.61 (16.7%) stddev-sans-first:62603.95 03:08:06 INFO - 2015-11-23 03:08:06,862 DEBUG : BROWSER_OUTPUT: Values: 359.0 359.6 359.9 360.1 360.6 14217.1 14380.4 16374.8 16671.0 17384.4 14102.6 14643.7 16486.8 16843.9 16950.3 5432.9 5638.1 5643.0 5644.9 5650.2 3876.8 3971.7 5371.9 5510.1 5547.4 5931.6 6052.1 6086.2 6086.4 6094.2 5914.3 6038.1 6041.2 6073.5 6082.9 5347.8 5347.9 5358.8 5359.6 5362.2 19477.3 19705.4 19713.3 20131.4 20228.0 2204.5 2333.0 2394.1 2410.3 2518.5 13104.2 13494.8 13499.9 13628.5 13736.4 1775.9 1881.2 1884.7 1919.1 1929.6 57933.4 59891.4 60008.0 60370.4 61390.7 9605.2 9713.0 9855.1 9949.0 9957.0 13153.8 13187.3 13192.2 13197.5 13200.2 7377.1 7399.3 7419.2 7436.9 7478.2 7265.5 7316.6 7458.4 7508.5 7526.0 5862.2 5979.9 5992.4 6041.6 6073.3 1667.0 1687.5 1708.3 1740.2 1761.5 420.0 421.0 433.5 965.9 1012.2 9710.6 9940.2 10050.1 10067.4 10276.2 400.4 400.7 400.9 403.0 435.2 5364.5 5597.9 5627.5 5663.4 5679.5 369834.0 373309.0 374963.0 376301.0 402291.0 75541.0 76227.6 78000.2 80944.6 81966.6 1139.4 1153.8 1186.8 1189.8 1191.2 13941.1 14583.3 14871.3 15306.2 15546.7 32834.5 33082.2 33338.0 33391.2 35637.6 43844.8 44737.0 45261.3 45661.8 46009.8 8954.4 9324.3 9378.6 9421.2 9434.3 10919.4 13395.3 16609.9 16895.6 16971.8 10340.5 11556.5 11867.1 13852.5 14390.3 13407.6 13652.8 13868.1 14064.9 14174.5 12762.4 13728.5 13989.5 14218.4 14322.4 8975.2 9031.3 9147.5 9175.9 9215.8 10059.0 10155.8 11650.9 14457.0 14997.5 03:08:06 INFO - 2015-11-23 03:08:06,862 DEBUG : BROWSER_OUTPUT: 03:08:06 INFO - 2015-11-23 03:08:06,862 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5152.61 Median:6264.92 stddev:2632.24 (42.0%) stddev-sans-first:2624.13 03:08:06 INFO - 2015-11-23 03:08:06,864 DEBUG : BROWSER_OUTPUT: Values: 1353.4 1465.7 1536.8 1666.5 1778.1 6511.4 7154.4 7401.9 7403.6 7409.3 7232.0 7248.4 7291.3 7293.7 7298.3 1934.4 1970.3 2159.6 2172.6 2175.8 2172.7 2246.9 2249.6 2250.3 2251.9 2124.2 2163.5 2168.6 2169.2 2169.3 1926.5 1966.5 1967.1 1968.9 2161.2 2187.1 2237.3 2241.3 2243.0 2243.5 7186.8 7326.9 7327.9 7330.6 7333.2 4401.2 4474.1 4510.1 4512.0 4512.0 2963.7 2996.6 2998.6 2999.4 3000.3 978.4 980.3 1002.4 1006.1 1039.8 9622.9 9625.2 9633.4 9638.1 9683.9 3992.5 4023.9 4071.4 4075.2 4084.3 8378.0 8404.8 8410.5 8413.9 8432.2 4534.1 4548.1 4575.7 4576.5 4581.4 4093.9 4098.4 4100.2 4101.2 4101.9 3546.4 3550.5 3555.0 3588.3 3622.9 1196.8 1200.7 1211.2 1223.0 1236.2 1078.1 1137.3 1340.9 1380.1 1381.5 7039.5 7081.6 7089.0 7094.9 7106.8 439.7 455.5 456.4 457.3 460.5 5318.1 5387.1 5433.7 5553.3 5849.1 8531.0 8759.4 8876.1 8928.2 8937.9 8359.2 8664.4 8670.3 8784.5 8791.3 6634.3 6643.1 6667.5 6684.8 6715.4 6889.7 6956.8 6967.2 6995.0 7015.7 7109.4 7589.0 7851.1 7859.6 7897.4 7794.4 7862.1 7927.0 8003.2 8177.7 6876.8 6942.1 6954.4 6955.4 6969.2 6861.1 7078.3 7149.7 7168.7 7188.5 6604.5 6697.7 6723.5 6736.0 6841.7 6547.8 6622.6 6628.6 6638.7 6741.7 6447.8 6538.4 6548.5 6567.8 6590.2 6244.9 6257.8 6261.7 6263.2 6266.7 6229.8 6240.4 6246.8 6246.8 6329.9 03:08:06 INFO - 2015-11-23 03:08:06,864 DEBUG : BROWSER_OUTPUT: 03:08:06 INFO - 2015-11-23 03:08:06,864 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5269.33 Median:6013.94 stddev:1581.21 (26.3%) stddev-sans-first:1541.48 03:08:06 INFO - 2015-11-23 03:08:06,864 DEBUG : BROWSER_OUTPUT: Values: 325.1 327.1 327.7 334.2 336.9 5929.7 5931.1 5972.6 5987.0 5989.3 5628.3 5707.6 5798.2 5899.4 5902.9 4571.7 4575.6 4587.0 4591.7 4602.9 4302.2 4584.2 4585.1 4587.9 4588.3 4340.5 4409.9 4531.8 4545.2 4556.3 4513.5 4514.1 4523.5 4525.5 4541.0 3981.1 3985.1 3987.2 3992.2 3999.4 5530.6 5623.4 5624.7 5626.0 5629.0 5253.1 5306.2 5308.5 5315.6 5317.9 6198.2 6224.1 6252.5 6261.7 6263.2 4445.4 4448.2 4452.7 4457.1 4458.1 6316.2 6440.5 6474.7 6477.8 6488.2 4537.6 4537.9 4545.5 4548.4 4553.9 4594.8 4598.0 4602.5 4610.7 4616.4 5273.2 5277.8 5279.5 5285.0 5296.6 6098.8 6259.2 6298.8 6308.8 6312.8 1554.0 1587.8 1588.4 1588.6 1589.5 1047.5 1057.3 1061.3 1063.2 1083.2 6047.7 6054.0 6054.6 6057.5 6067.2 6438.2 6448.0 6448.2 6455.2 6483.2 5932.6 6038.6 6041.2 6044.2 6049.3 3434.5 3496.4 3505.1 3507.0 3513.5 6664.1 6676.3 6737.2 6753.4 6765.9 6511.7 6678.7 6679.1 6680.0 6685.2 6753.9 6759.5 6764.9 6765.3 6771.2 6496.5 6502.3 6504.6 6508.3 6515.1 6282.6 6431.3 6438.2 6441.7 6446.7 6757.5 6759.4 6760.3 6762.7 6768.8 4477.9 4478.1 4480.5 4485.7 4488.4 6303.7 6431.6 6450.2 6451.3 6464.3 6305.5 6317.5 6337.3 6340.8 6345.0 6258.4 6286.3 6293.2 6295.9 6311.5 6080.5 6188.7 6212.0 6226.2 6237.3 6350.9 6354.6 6361.2 6383.0 6383.0 6217.5 6229.3 6232.0 6253.3 6257.8 03:08:06 INFO - 2015-11-23 03:08:06,865 DEBUG : BROWSER_OUTPUT: 03:08:06 INFO - 2015-11-23 03:08:06,866 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13695.26 Median:46468.65 stddev:16097.04 (34.6%) stddev-sans-first:16112.99 03:08:06 INFO - 2015-11-23 03:08:06,866 DEBUG : BROWSER_OUTPUT: Values: 783.3 847.0 864.8 867.4 869.8 13915.9 14237.9 14238.1 14254.3 14265.9 10826.0 13217.7 13300.7 13329.2 13335.5 670.7 809.8 821.6 824.4 825.5 821.4 821.6 827.3 828.3 828.9 710.5 719.9 859.3 866.2 867.0 832.3 859.2 860.8 860.8 861.1 632.7 635.8 637.4 639.6 639.7 13355.7 13447.0 13540.5 13557.5 13568.1 12230.3 12594.9 12806.7 12812.0 12981.1 10436.7 10437.9 10450.6 10483.2 10638.1 3617.0 3624.1 3669.9 3708.8 3737.5 45993.3 46028.0 46418.0 46472.5 47255.7 10028.7 10061.9 10095.7 10198.3 10292.3 18061.4 18077.1 18184.4 18213.0 18240.6 7391.3 7611.0 7615.6 7618.2 7674.0 4291.5 4436.7 4455.8 4493.8 4613.1 3041.5 3079.2 3086.4 3087.0 3088.6 542.5 549.0 554.7 559.6 560.0 524.7 535.0 655.1 656.9 674.3 7922.7 8296.3 8312.3 8385.1 8431.5 603.3 611.2 612.9 633.6 647.1 3766.2 3961.3 3972.6 4043.0 4079.6 57566.7 58301.0 58555.0 58723.0 58894.1 51575.7 52046.5 52429.0 52479.0 52679.0 45745.3 46464.8 46685.1 47089.0 47458.3 8249.9 8285.8 8401.8 8616.3 8659.2 35020.6 35692.0 36123.8 36174.8 36394.3 42616.1 42675.4 46540.5 46876.5 46906.0 10032.3 10091.8 10257.5 10367.7 10890.6 10614.9 10674.5 10811.6 10851.2 11061.2 10365.8 10603.8 10847.0 10928.3 10932.3 10173.5 10383.9 10503.4 10847.7 10851.9 9765.8 10246.6 10324.1 10369.7 10557.2 8648.0 8685.1 8755.6 8857.3 8984.6 8391.8 8588.7 8868.4 9176.3 9204.7 03:08:06 INFO - 2015-11-23 03:08:06,866 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:08:06 INFO - 2015-11-23 03:08:06,867 DEBUG : BROWSER_OUTPUT: 03:08:07 INFO - 2015-11-23 03:08:07,604 INFO : Browser exited with error code: 0 03:08:07 INFO - 2015-11-23 03:08:07,620 INFO : Completed test dromaeo_css (00:18:33) 03:08:07 INFO - 2015-11-23 03:08:07,620 INFO : Starting test kraken 03:08:07 INFO - 2015-11-23 03:08:07,620 DEBUG : operating with platform_type : linux_ 03:08:07 INFO - 2015-11-23 03:08:07,620 INFO : Initialising browser for kraken test... 03:08:07 INFO - 2015-11-23 03:08:07,626 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLNnhAF/profile http://localhost:33393/getInfo.html 03:08:11 INFO - 2015-11-23 03:08:11,480 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:08:11 INFO - 2015-11-23 03:08:11,481 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:08:11 INFO - 2015-11-23 03:08:11,481 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:08:11 INFO - 2015-11-23 03:08:11,481 DEBUG : BROWSER_OUTPUT: __metrics 03:08:11 INFO - 2015-11-23 03:08:11,618 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:08:12 INFO - 2015-11-23 03:08:12,695 INFO : Browser initialized. 03:08:12 INFO - 2015-11-23 03:08:12,696 INFO : Running cycle 1/1 for kraken test... 03:08:12 INFO - 2015-11-23 03:08:12,696 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLNnhAF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:08:24 INFO - 2015-11-23 03:08:24,449 DEBUG : BROWSER_OUTPUT: RSS: Main: 142360576 03:08:24 INFO - 2015-11-23 03:08:24,449 DEBUG : BROWSER_OUTPUT: 03:08:26 INFO - 2015-11-23 03:08:26,886 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33393/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33393/tests/kraken/driver.html?testName=audio-beat-detection) 03:08:27 INFO - 2015-11-23 03:08:27,467 DEBUG : BROWSER_OUTPUT: RSS: Main: 176238592 03:08:27 INFO - 2015-11-23 03:08:27,468 DEBUG : BROWSER_OUTPUT: 03:08:30 INFO - 2015-11-23 03:08:30,029 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33393/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33393/tests/kraken/driver.html?testName=audio-dft) 03:08:30 INFO - 2015-11-23 03:08:30,602 DEBUG : BROWSER_OUTPUT: RSS: Main: 164794368 03:08:30 INFO - 2015-11-23 03:08:30,602 DEBUG : BROWSER_OUTPUT: 03:08:33 INFO - 2015-11-23 03:08:33,485 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33393/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33393/tests/kraken/driver.html?testName=audio-fft) 03:08:34 INFO - 2015-11-23 03:08:34,046 DEBUG : BROWSER_OUTPUT: RSS: Main: 151474176 03:08:34 INFO - 2015-11-23 03:08:34,046 DEBUG : BROWSER_OUTPUT: 03:08:36 INFO - 2015-11-23 03:08:36,045 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33393/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33393/tests/kraken/driver.html?testName=audio-oscillator) 03:08:36 INFO - 2015-11-23 03:08:36,618 DEBUG : BROWSER_OUTPUT: RSS: Main: 154808320 03:08:36 INFO - 2015-11-23 03:08:36,618 DEBUG : BROWSER_OUTPUT: 03:08:38 INFO - 2015-11-23 03:08:38,796 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33393/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33393/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:08:39 INFO - 2015-11-23 03:08:39,357 DEBUG : BROWSER_OUTPUT: RSS: Main: 155688960 03:08:39 INFO - 2015-11-23 03:08:39,357 DEBUG : BROWSER_OUTPUT: 03:08:42 INFO - 2015-11-23 03:08:42,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33393/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33393/tests/kraken/driver.html?testName=imaging-darkroom) 03:08:42 INFO - 2015-11-23 03:08:42,830 DEBUG : BROWSER_OUTPUT: RSS: Main: 155684864 03:08:42 INFO - 2015-11-23 03:08:42,830 DEBUG : BROWSER_OUTPUT: 03:08:46 INFO - 2015-11-23 03:08:46,204 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33393/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33393/tests/kraken/driver.html?testName=imaging-desaturate) 03:08:46 INFO - 2015-11-23 03:08:46,777 DEBUG : BROWSER_OUTPUT: RSS: Main: 157196288 03:08:46 INFO - 2015-11-23 03:08:46,777 DEBUG : BROWSER_OUTPUT: 03:08:49 INFO - 2015-11-23 03:08:49,555 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33393/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33393/tests/kraken/driver.html?testName=json-parse-financial) 03:08:50 INFO - 2015-11-23 03:08:50,122 DEBUG : BROWSER_OUTPUT: RSS: Main: 157335552 03:08:50 INFO - 2015-11-23 03:08:50,123 DEBUG : BROWSER_OUTPUT: 03:08:51 INFO - 2015-11-23 03:08:51,659 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33393/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33393/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:08:52 INFO - 2015-11-23 03:08:52,221 DEBUG : BROWSER_OUTPUT: RSS: Main: 167436288 03:08:52 INFO - 2015-11-23 03:08:52,221 DEBUG : BROWSER_OUTPUT: 03:08:54 INFO - 2015-11-23 03:08:54,019 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33393/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33393/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:08:54 INFO - 2015-11-23 03:08:54,614 DEBUG : BROWSER_OUTPUT: RSS: Main: 167174144 03:08:54 INFO - 2015-11-23 03:08:54,614 DEBUG : BROWSER_OUTPUT: 03:08:56 INFO - 2015-11-23 03:08:56,653 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33393/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33393/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:08:57 INFO - 2015-11-23 03:08:57,222 DEBUG : BROWSER_OUTPUT: RSS: Main: 170864640 03:08:57 INFO - 2015-11-23 03:08:57,222 DEBUG : BROWSER_OUTPUT: 03:08:59 INFO - 2015-11-23 03:08:59,608 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33393/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33393/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:09:00 INFO - 2015-11-23 03:09:00,193 DEBUG : BROWSER_OUTPUT: RSS: Main: 181862400 03:09:00 INFO - 2015-11-23 03:09:00,194 DEBUG : BROWSER_OUTPUT: 03:09:02 INFO - 2015-11-23 03:09:02,728 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33393/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33393/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:09:03 INFO - 2015-11-23 03:09:03,296 DEBUG : BROWSER_OUTPUT: RSS: Main: 181141504 03:09:03 INFO - 2015-11-23 03:09:03,296 DEBUG : BROWSER_OUTPUT: 03:09:04 INFO - 2015-11-23 03:09:04,945 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33393/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33393/tests/kraken/driver.html?testName=ai-astar) 03:09:05 INFO - 2015-11-23 03:09:05,195 DEBUG : BROWSER_OUTPUT: RSS: Main: 238960640 03:09:05 INFO - 2015-11-23 03:09:05,195 DEBUG : BROWSER_OUTPUT: 03:09:05 INFO - 2015-11-23 03:09:05,197 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:09:05 INFO - 2015-11-23 03:09:05,197 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:09:05 INFO - 2015-11-23 03:09:05,197 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:09:05 INFO - 2015-11-23 03:09:05,197 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:09:05 INFO - 2015-11-23 03:09:05,197 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;112;104;109;109;111;99;108;110;101 03:09:05 INFO - 2015-11-23 03:09:05,198 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;147;122;154;168;126;147;145;124;159;124 03:09:05 INFO - 2015-11-23 03:09:05,198 DEBUG : BROWSER_OUTPUT: |2;audio-dft;166;167;168;167;169;167;166;167;167;167 03:09:05 INFO - 2015-11-23 03:09:05,198 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;84;96;70;71;72;106;93;70 03:09:05 INFO - 2015-11-23 03:09:05,198 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;138;93;94;93;138;92;93;138 03:09:05 INFO - 2015-11-23 03:09:05,198 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;109;110;109;110;109;110 03:09:05 INFO - 2015-11-23 03:09:05,198 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;145;145;145;146;145;146;145;145 03:09:05 INFO - 2015-11-23 03:09:05,199 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;96;96;96;96;96 03:09:05 INFO - 2015-11-23 03:09:05,199 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;58;60;58;60;59;59;66;57;57 03:09:05 INFO - 2015-11-23 03:09:05,199 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;68;68;69;68;68;69;69;69 03:09:05 INFO - 2015-11-23 03:09:05,199 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;84;86;82;83;84;85;86;84;83 03:09:05 INFO - 2015-11-23 03:09:05,199 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;117;113;110;120;118;113;124;129;118 03:09:05 INFO - 2015-11-23 03:09:05,199 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;148;141;146;154;149;139;147;145;147;135 03:09:05 INFO - 2015-11-23 03:09:05,199 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;67;67;66;66;68;66;65;65;68 03:09:05 INFO - 2015-11-23 03:09:05,199 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:09:05 INFO - 2015-11-23 03:09:05,199 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:09:05 INFO - 2015-11-23 03:09:05,200 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,925 03:09:05 INFO - 2015-11-23 03:09:05,200 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:09:05 INFO - 2015-11-23 03:09:05,200 DEBUG : BROWSER_OUTPUT: __startTimestamp1448276945195__endTimestamp 03:09:05 INFO - 2015-11-23 03:09:05,200 DEBUG : BROWSER_OUTPUT: 03:09:05 INFO - 2015-11-23 03:09:05,201 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:09:05 INFO - 2015-11-23 03:09:05,201 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:09:05 INFO - 2015-11-23 03:09:05,201 DEBUG : BROWSER_OUTPUT: 03:09:05 INFO - 2015-11-23 03:09:05,201 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.10 Median:109.50 stddev:4.33 (4.0%) stddev-sans-first:4.58 03:09:05 INFO - 2015-11-23 03:09:05,201 DEBUG : BROWSER_OUTPUT: Values: 108.0 112.0 104.0 109.0 109.0 111.0 99.0 108.0 110.0 101.0 03:09:05 INFO - 2015-11-23 03:09:05,202 DEBUG : BROWSER_OUTPUT: 03:09:05 INFO - 2015-11-23 03:09:05,202 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.60 Median:147.00 stddev:16.57 (11.3%) stddev-sans-first:17.46 03:09:05 INFO - 2015-11-23 03:09:05,202 DEBUG : BROWSER_OUTPUT: Values: 147.0 122.0 154.0 168.0 126.0 147.0 145.0 124.0 159.0 124.0 03:09:05 INFO - 2015-11-23 03:09:05,202 DEBUG : BROWSER_OUTPUT: 03:09:05 INFO - 2015-11-23 03:09:05,202 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:167.10 Median:167.00 stddev:0.88 (0.5%) stddev-sans-first:0.83 03:09:05 INFO - 2015-11-23 03:09:05,202 DEBUG : BROWSER_OUTPUT: Values: 166.0 167.0 168.0 167.0 169.0 167.0 166.0 167.0 167.0 167.0 03:09:05 INFO - 2015-11-23 03:09:05,202 DEBUG : BROWSER_OUTPUT: 03:09:05 INFO - 2015-11-23 03:09:05,202 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.60 Median:72.00 stddev:13.28 (18.4%) stddev-sans-first:13.71 03:09:05 INFO - 2015-11-23 03:09:05,202 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 84.0 96.0 70.0 71.0 72.0 106.0 93.0 70.0 03:09:05 INFO - 2015-11-23 03:09:05,203 DEBUG : BROWSER_OUTPUT: 03:09:05 INFO - 2015-11-23 03:09:05,203 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.50 Median:93.00 stddev:21.74 (23.4%) stddev-sans-first:22.51 03:09:05 INFO - 2015-11-23 03:09:05,204 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 138.0 93.0 94.0 93.0 138.0 92.0 93.0 138.0 03:09:05 INFO - 2015-11-23 03:09:05,204 DEBUG : BROWSER_OUTPUT: 03:09:05 INFO - 2015-11-23 03:09:05,204 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 03:09:05 INFO - 2015-11-23 03:09:05,204 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 109.0 110.0 109.0 110.0 109.0 110.0 03:09:05 INFO - 2015-11-23 03:09:05,205 DEBUG : BROWSER_OUTPUT: 03:09:05 INFO - 2015-11-23 03:09:05,205 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 03:09:05 INFO - 2015-11-23 03:09:05,205 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 145.0 145.0 145.0 146.0 145.0 146.0 145.0 145.0 03:09:05 INFO - 2015-11-23 03:09:05,205 DEBUG : BROWSER_OUTPUT: 03:09:05 INFO - 2015-11-23 03:09:05,205 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 03:09:05 INFO - 2015-11-23 03:09:05,205 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 03:09:05 INFO - 2015-11-23 03:09:05,205 DEBUG : BROWSER_OUTPUT: 03:09:05 INFO - 2015-11-23 03:09:05,206 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.20 Median:59.00 stddev:2.62 (4.4%) stddev-sans-first:2.74 03:09:05 INFO - 2015-11-23 03:09:05,206 DEBUG : BROWSER_OUTPUT: Values: 58.0 58.0 60.0 58.0 60.0 59.0 59.0 66.0 57.0 57.0 03:09:05 INFO - 2015-11-23 03:09:05,206 DEBUG : BROWSER_OUTPUT: 03:09:05 INFO - 2015-11-23 03:09:05,206 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.52 (0.7%) stddev-sans-first:0.53 03:09:05 INFO - 2015-11-23 03:09:05,206 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 68.0 69.0 68.0 68.0 69.0 69.0 69.0 03:09:05 INFO - 2015-11-23 03:09:05,206 DEBUG : BROWSER_OUTPUT: 03:09:05 INFO - 2015-11-23 03:09:05,206 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:1.45 (1.7%) stddev-sans-first:1.36 03:09:05 INFO - 2015-11-23 03:09:05,206 DEBUG : BROWSER_OUTPUT: Values: 82.0 84.0 86.0 82.0 83.0 84.0 85.0 86.0 84.0 83.0 03:09:05 INFO - 2015-11-23 03:09:05,206 DEBUG : BROWSER_OUTPUT: 03:09:05 INFO - 2015-11-23 03:09:05,206 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.50 Median:119.00 stddev:5.76 (4.8%) stddev-sans-first:5.87 03:09:05 INFO - 2015-11-23 03:09:05,206 DEBUG : BROWSER_OUTPUT: Values: 123.0 117.0 113.0 110.0 120.0 118.0 113.0 124.0 129.0 118.0 03:09:05 INFO - 2015-11-23 03:09:05,207 DEBUG : BROWSER_OUTPUT: 03:09:05 INFO - 2015-11-23 03:09:05,207 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.10 Median:147.00 stddev:5.45 (3.7%) stddev-sans-first:5.67 03:09:05 INFO - 2015-11-23 03:09:05,207 DEBUG : BROWSER_OUTPUT: Values: 148.0 141.0 146.0 154.0 149.0 139.0 147.0 145.0 147.0 135.0 03:09:05 INFO - 2015-11-23 03:09:05,207 DEBUG : BROWSER_OUTPUT: 03:09:05 INFO - 2015-11-23 03:09:05,207 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.79 (2.7%) stddev-sans-first:1.13 03:09:05 INFO - 2015-11-23 03:09:05,207 DEBUG : BROWSER_OUTPUT: Values: 71.0 67.0 67.0 66.0 66.0 68.0 66.0 65.0 65.0 68.0 03:09:05 INFO - 2015-11-23 03:09:05,207 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:09:05 INFO - 2015-11-23 03:09:05,207 DEBUG : BROWSER_OUTPUT: 03:09:06 INFO - 2015-11-23 03:09:06,052 INFO : Browser exited with error code: 0 03:09:06 INFO - 2015-11-23 03:09:06,103 INFO : Completed test kraken (00:00:58) 03:09:06 INFO - 2015-11-23 03:09:06,103 INFO : Starting test v8_7 03:09:06 INFO - 2015-11-23 03:09:06,103 DEBUG : operating with platform_type : linux_ 03:09:06 INFO - 2015-11-23 03:09:06,103 INFO : Initialising browser for v8_7 test... 03:09:06 INFO - 2015-11-23 03:09:06,109 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYVAmMP/profile http://localhost:33393/getInfo.html 03:09:10 INFO - 2015-11-23 03:09:10,153 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:09:10 INFO - 2015-11-23 03:09:10,153 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:09:10 INFO - 2015-11-23 03:09:10,153 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:09:10 INFO - 2015-11-23 03:09:10,153 DEBUG : BROWSER_OUTPUT: __metrics 03:09:10 INFO - 2015-11-23 03:09:10,290 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:09:11 INFO - 2015-11-23 03:09:11,428 INFO : Browser initialized. 03:09:11 INFO - 2015-11-23 03:09:11,429 INFO : Running cycle 1/1 for v8_7 test... 03:09:11 INFO - 2015-11-23 03:09:11,429 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYVAmMP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:09:23 INFO - 2015-11-23 03:09:23,132 DEBUG : BROWSER_OUTPUT: RSS: Main: 139849728 03:09:23 INFO - 2015-11-23 03:09:23,132 DEBUG : BROWSER_OUTPUT: 03:09:44 INFO - 2015-11-23 03:09:44,597 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33393/tests/v8_7/run.html (next: http://localhost:33393/tests/v8_7/run.html) 03:09:44 INFO - 2015-11-23 03:09:44,855 DEBUG : BROWSER_OUTPUT: RSS: Main: 543199232 03:09:44 INFO - 2015-11-23 03:09:44,855 DEBUG : BROWSER_OUTPUT: 03:09:44 INFO - 2015-11-23 03:09:44,855 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:09:44 INFO - 2015-11-23 03:09:44,855 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:09:44 INFO - 2015-11-23 03:09:44,856 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:09:44 INFO - 2015-11-23 03:09:44,856 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:09:44 INFO - 2015-11-23 03:09:44,856 DEBUG : BROWSER_OUTPUT: |0;Richards;192.4557351809084 03:09:44 INFO - 2015-11-23 03:09:44,856 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.66614755693985 03:09:44 INFO - 2015-11-23 03:09:44,856 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.6569883290635 03:09:44 INFO - 2015-11-23 03:09:44,856 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4995.024875621891 03:09:44 INFO - 2015-11-23 03:09:44,856 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1101.3215859030836 03:09:44 INFO - 2015-11-23 03:09:44,857 DEBUG : BROWSER_OUTPUT: |5;Earley;781.8608287724785 03:09:44 INFO - 2015-11-23 03:09:44,857 DEBUG : BROWSER_OUTPUT: |6;Boyer;12231.707317073171 03:09:44 INFO - 2015-11-23 03:09:44,857 DEBUG : BROWSER_OUTPUT: |7;RegExp;25871.79487179487 03:09:44 INFO - 2015-11-23 03:09:44,857 DEBUG : BROWSER_OUTPUT: |8;Splay;564.9717514124294 03:09:44 INFO - 2015-11-23 03:09:44,857 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 03:09:44 INFO - 2015-11-23 03:09:44,857 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:09:44 INFO - 2015-11-23 03:09:44,857 DEBUG : BROWSER_OUTPUT: __startTimestamp1448276984848__endTimestamp 03:09:44 INFO - 2015-11-23 03:09:44,857 DEBUG : BROWSER_OUTPUT: 03:09:44 INFO - 2015-11-23 03:09:44,858 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:09:44 INFO - 2015-11-23 03:09:44,858 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:09:44 INFO - 2015-11-23 03:09:44,858 DEBUG : BROWSER_OUTPUT: 03:09:44 INFO - 2015-11-23 03:09:44,858 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:192.46 Median:192.46 stddev:0.00 (0.0%) 03:09:44 INFO - 2015-11-23 03:09:44,858 DEBUG : BROWSER_OUTPUT: Values: 192.5 03:09:44 INFO - 2015-11-23 03:09:44,858 DEBUG : BROWSER_OUTPUT: 03:09:44 INFO - 2015-11-23 03:09:44,858 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.67 Median:194.67 stddev:0.00 (0.0%) 03:09:44 INFO - 2015-11-23 03:09:44,859 DEBUG : BROWSER_OUTPUT: Values: 194.7 03:09:44 INFO - 2015-11-23 03:09:44,859 DEBUG : BROWSER_OUTPUT: 03:09:44 INFO - 2015-11-23 03:09:44,859 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.66 Median:284.66 stddev:0.00 (0.0%) 03:09:44 INFO - 2015-11-23 03:09:44,859 DEBUG : BROWSER_OUTPUT: Values: 284.7 03:09:44 INFO - 2015-11-23 03:09:44,859 DEBUG : BROWSER_OUTPUT: 03:09:44 INFO - 2015-11-23 03:09:44,859 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4995.02 Median:4995.02 stddev:0.00 (0.0%) 03:09:44 INFO - 2015-11-23 03:09:44,859 DEBUG : BROWSER_OUTPUT: Values: 4995.0 03:09:44 INFO - 2015-11-23 03:09:44,859 DEBUG : BROWSER_OUTPUT: 03:09:44 INFO - 2015-11-23 03:09:44,859 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1101.32 Median:1101.32 stddev:0.00 (0.0%) 03:09:44 INFO - 2015-11-23 03:09:44,859 DEBUG : BROWSER_OUTPUT: Values: 1101.3 03:09:44 INFO - 2015-11-23 03:09:44,860 DEBUG : BROWSER_OUTPUT: 03:09:44 INFO - 2015-11-23 03:09:44,860 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:781.86 Median:781.86 stddev:0.00 (0.0%) 03:09:44 INFO - 2015-11-23 03:09:44,860 DEBUG : BROWSER_OUTPUT: Values: 781.9 03:09:44 INFO - 2015-11-23 03:09:44,860 DEBUG : BROWSER_OUTPUT: 03:09:44 INFO - 2015-11-23 03:09:44,860 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12231.71 Median:12231.71 stddev:0.00 (0.0%) 03:09:44 INFO - 2015-11-23 03:09:44,860 DEBUG : BROWSER_OUTPUT: Values: 12231.7 03:09:44 INFO - 2015-11-23 03:09:44,860 DEBUG : BROWSER_OUTPUT: 03:09:44 INFO - 2015-11-23 03:09:44,860 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25871.79 Median:25871.79 stddev:0.00 (0.0%) 03:09:44 INFO - 2015-11-23 03:09:44,860 DEBUG : BROWSER_OUTPUT: Values: 25871.8 03:09:44 INFO - 2015-11-23 03:09:44,860 DEBUG : BROWSER_OUTPUT: 03:09:44 INFO - 2015-11-23 03:09:44,860 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:564.97 Median:564.97 stddev:0.00 (0.0%) 03:09:44 INFO - 2015-11-23 03:09:44,860 DEBUG : BROWSER_OUTPUT: Values: 565.0 03:09:44 INFO - 2015-11-23 03:09:44,860 DEBUG : BROWSER_OUTPUT: 03:09:44 INFO - 2015-11-23 03:09:44,860 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 03:09:44 INFO - 2015-11-23 03:09:44,860 DEBUG : BROWSER_OUTPUT: Values: 4835.7 03:09:44 INFO - 2015-11-23 03:09:44,860 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:09:44 INFO - 2015-11-23 03:09:44,861 DEBUG : BROWSER_OUTPUT: 03:09:45 INFO - 2015-11-23 03:09:45,748 INFO : Browser exited with error code: 0 03:09:45 INFO - 2015-11-23 03:09:45,762 INFO : Completed test v8_7 (00:00:39) 03:09:45 INFO - 2015-11-23 03:09:45,813 INFO : Completed test suite (00:20:12) 03:09:45 INFO - 2015-11-23 03:09:45,813 DEBUG : Working with test: dromaeo_css 03:09:45 INFO - 2015-11-23 03:09:45,813 DEBUG : Generating results file: dromaeo_css 03:09:45 INFO - 2015-11-23 03:09:45,815 DEBUG : Working with test: kraken 03:09:45 INFO - 2015-11-23 03:09:45,815 DEBUG : Generating results file: kraken 03:09:45 INFO - 2015-11-23 03:09:45,815 INFO : javascript benchmark 03:09:45 INFO - 2015-11-23 03:09:45,815 DEBUG : Working with test: v8_7 03:09:45 INFO - 2015-11-23 03:09:45,815 DEBUG : Generating results file: v8_7 03:09:45 INFO - 2015-11-23 03:09:45,816 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:09:45 INFO - 2015-11-23 03:09:45,862 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 03:09:45 INFO - 2015-11-23 03:09:45,862 DEBUG : process_Request line: dromaeo_css 6893.11 graph.html#tests=[[72,63,35]] 03:09:45 INFO - 2015-11-23 03:09:45,862 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:09:45 INFO - 2015-11-23 03:09:45,893 DEBUG : process_Request line: kraken 1495.70 graph.html#tests=[[232,63,35]] 03:09:45 INFO - 2015-11-23 03:09:45,893 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:09:45 INFO - 2015-11-23 03:09:45,931 DEBUG : process_Request line: v8_7 20873.85 graph.html#tests=[[230,63,35]] 03:09:45 INFO - 2015-11-23 03:09:45,932 INFO : javascript benchmark 03:09:45 INFO - 2015-11-23 03:09:45,936 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3178.5391118287844, 3245.204924793426, 3292.588426446694, 3297.1757060734817, 3318.021183750793, 5344.278522399475, 5427.837164885055, 5447.373552041517, 5466.398696143426, 5478.315210598676, 5382.650127741694, 5433.293671822667, 5433.701146436954, 5493.862653433656, 5516.9172462413, 4882.170031094723, 4888.217885138379, 4901.779419926094, 4967.726775027372, 5069.467705890884, 5052.242163675442, 5067.493250674921, 5098.464661210575, 5103.948960510403, 5122.590192784568, 4829.565339119478, 4832.951670483285, 4921.950780492203, 4942.283368911523, 4956.983818317236, 5006.649534532584, 5013.022460620181, 5015.272785446126, 5020.77406516704, 5068.949310506885, 4954.777035033432, 5002.899942001176, 5003.4996500350035, 5028.748562571894, 5074.238864170367, 5076.796928122871, 5283.181106928432, 5293.814716484904, 5395.433479484676, 5435.592330575183, 5901.586888917777, 5945.851353716149, 5946.43508866657, 5960.97019514904, 5965.433283838029, 5704.515116215127, 5930.080837470199, 5935.080062590306, 5939.227900372967, 5942.257217847769, 5317.707526086064, 5359.035373632783, 5416.647917885403, 5476.0416927038, 5509.283793106871, 6039.607425517327, 6043.54673399488, 6053.828449898408, 6055.6063855849225, 6109.938900611026, 5519.199716041232, 5815.098659707752, 5819.127130930309, 5823.126531020296, 5881.852953676193, 5813.476787089182, 5909.054551271776, 5969.0, 5969.373215812364, 6026.337102918676, 5921.259842519685, 5940.910886336708, 5955.225820643289, 5963.940360596339, 5974.492168165668, 5777.624454410534, 5921.911171332434, 5946.345901950782, 5962.5826192167, 5966.254218222723, 4417.3815665806815, 4421.7789110544345, 4435.423394958635, 4445.755483448376, 4505.211587972091, 4037.5760545142925, 4067.2272268269526, 4068.6745060395097, 4113.938290925638, 4117.053077792125, 5663.858403539862, 5677.687727174963, 5682.261306030189, 5683.062294721325, 5683.147527870852, 5770.942290577124, 5829.271341082364, 5863.618864773776, 5870.119482077637, 6021.337652858182, 5635.1828984796975, 5662.348829884533, 5669.6314739541795, 5671.716414179275, 5672.602917795797, 5226.0, 5232.555232805178, 5233.241180028875, 5233.398159211663, 5272.209168624737, 5950.613210141327, 6088.786892458743, 6100.359462256488, 6105.542084343692, 6173.69131543412, 5924.822255332347, 6023.1868697726995, 6029.728662210124, 6031.4270144336215, 6036.154938308552, 6191.690415479298, 6227.0, 6246.906296405648, 6249.78125765596, 6250.406211409909, 5706.600537962303, 5741.74162162712, 5832.183494310885, 5833.1250312451775, 5930.406959304035, 5946.73239704223, 5954.702264886651, 5989.341172470938, 5996.70016499182, 6003.489703375262, 5762.740676669476, 5764.279465066867, 5766.5675074368755, 5798.1302804579655, 5812.82561523155, 5600.691961942132, 5690.630109042899, 5691.573132015198, 5772.422757724194, 5779.479846813807, 5454.536364409069, 5515.4760297771645, 5524.779008839601, 5565.860853478695, 5591.245181900392, 5739.942600573941, 5747.367789543064, 5781.046127388934, 5783.913241301468, 5809.186713859978, 5510.421405752499, 5618.2134501170685, 5704.172894930295, 5711.0, 5718.771249150153], "unit": "ms", "name": "dojo.html", "value": 5438.229679090025}, {"lowerIsBetter": false, "replicates": [575.7380391921674, 577.0997244298894, 577.1198921644494, 582.1616871704745, 593.8782549577337, 30746.84626576867, 39341.0, 39823.80088099563, 39941.60058399415, 40034.0, 42899.211551249144, 43347.3497897531, 43447.78276108615, 43530.347044794355, 43562.0, 7587.962060189691, 7707.07515098189, 8672.653093876237, 8835.293176545862, 8849.646014159425, 10457.58169673212, 10695.625653102143, 10699.197560182978, 10699.411532365717, 10706.41114738689, 10417.895821041768, 10509.369437833717, 10536.894631053707, 10538.104261137813, 10540.47297635119, 7774.02824646922, 7952.721654742114, 10136.391816491034, 10315.277930544866, 10379.377237365745, 9929.652462163862, 9955.402675839472, 10015.69952901414, 10016.499175041292, 10065.849012264749, 35407.645923540695, 35456.0, 35655.4651680225, 35812.104697382514, 35857.820710896536, 3189.7607679423904, 3221.742260619145, 3387.4072037393357, 3673.81630918453, 4136.193442278757, 29457.263568410748, 29578.0, 29938.101856944108, 30258.0, 30983.845080774678, 3918.294706952747, 3947.822347994347, 4018.417329487208, 4101.774402407867, 4230.936535951963, 267332.0, 268717.0, 269423.0, 269757.0, 269880.0, 57416.42583574111, 58631.0, 59790.70104649536, 66484.0, 67524.32475675279, 61142.0, 61762.0, 61789.910504474596, 62082.0, 62132.378676213564, 15630.374785008473, 15858.60353491172, 15880.20598970047, 15880.52358429249, 15881.205939702968, 12006.21959572625, 12070.094742894318, 12071.215371000857, 12075.09436792244, 12233.510659573518, 20037.699434508493, 20226.19095236174, 20300.0, 20305.593888122155, 20307.28924487636, 7981.48120372174, 8009.599520023976, 8181.71364002269, 8234.752957411287, 8247.268073704588, 900.9459432434074, 953.2135987810084, 1016.9237307201989, 1079.3308148947704, 1079.6922876980022, 27831.860840695666, 27866.44267114687, 32225.194370140933, 32862.0, 32937.67062329394, 1009.2329829329616, 1009.6365308488938, 1011.3173607814696, 1023.9385636861812, 1077.498962982217, 14019.579412617637, 14215.928920355333, 14252.216128113054, 14364.856351436561, 14544.200068996306, 368636.0, 372961.0, 373376.13311933266, 373768.0, 373771.0, 51738.0, 52471.475285246655, 52500.212496811815, 52605.7369713149, 52606.73696631492, 1342.214804339453, 1351.770199066161, 1363.4614327340646, 1365.3582816076428, 1367.8153449284218, 24991.625125623494, 31564.842175788974, 31984.560694768326, 32283.35433291368, 32356.514652280704, 46077.76961115173, 46737.53262467332, 46753.2987005202, 46762.0, 46802.0, 308010.0, 310149.0, 310769.0, 311009.0, 311186.0, 31955.201119972186, 45789.542104578526, 45790.31314530218, 46171.76914115408, 46963.765181173876, 43417.78291108524, 43478.347824782024, 43491.0, 43745.562544375425, 44438.55561444473, 36443.45334820033, 36653.26693466169, 37540.2491950154, 37543.62456375401, 37811.62188378081, 31985.680143199203, 36612.81693591515, 37233.25533489369, 37372.0, 39562.80218598888, 36580.26839463143, 36651.08372290714, 36768.0, 36789.632103679694, 37647.81176094212, 31698.366032678758, 31756.523652144773, 33812.4667498642, 34220.657793422746, 34233.65766342404, 25474.23577292684, 25692.357691057874, 26080.73919260783, 26505.0, 27951.34462226085], "unit": "ms", "name": "ext.html", "value": 19275.801151266347}, {"lowerIsBetter": false, "replicates": [358.9892303230904, 359.6026390838124, 359.92621512589903, 360.1069348016917, 360.6123417326375, 14217.075890067139, 14380.352884120213, 16374.754378684314, 16671.0, 17384.391546295883, 14102.64743381416, 14643.707125857476, 16486.83513164868, 16843.90514616549, 16950.3219871205, 5432.864178395552, 5638.126090455966, 5643.0, 5644.943550564503, 5650.152477128443, 3876.8255428505786, 3971.7021223408215, 5371.892562148755, 5510.090835012218, 5547.417521160281, 5931.555133365015, 6052.092186172065, 6086.17836592061, 6086.360932102132, 6094.238220222473, 5914.260717410302, 6038.064100064497, 6041.214642096521, 6073.483753880925, 6082.908756368658, 5347.786088556453, 5347.893042139135, 5358.839234822962, 5359.624826262163, 5362.168863826074, 19477.31829385979, 19705.408837734893, 19713.310034148737, 20131.39605811828, 20228.0, 2204.481946742514, 2332.976670233293, 2394.078279862248, 2410.3130607776698, 2518.4585314157544, 13104.172995801582, 13494.797578036338, 13499.86500134996, 13628.454861805516, 13736.381862816197, 1775.9112044397857, 1881.1628825172804, 1884.7172924061501, 1919.0980239287512, 1929.556202073531, 57933.42066579322, 59891.40108598902, 60008.0, 60370.39629603692, 61390.693046534485, 9605.18355939739, 9712.951435242778, 9855.11303982645, 9948.950255248677, 9957.0, 13153.802692959613, 13187.296604196117, 13192.20846749198, 13197.53808616713, 13200.20798752078, 7377.077865266841, 7399.260073992557, 7419.183889772121, 7436.888446673304, 7478.214787447239, 7265.527740696838, 7316.597587132653, 7458.4033277337685, 7508.474406791582, 7526.02161718973, 5862.237909071793, 5979.880402391927, 5992.40075992406, 6041.577089603774, 6073.271207455045, 1666.983330166707, 1687.4684474390529, 1708.325211541434, 1740.1895938059943, 1761.4979730776668, 419.9517055538591, 420.97474151551006, 433.5252898076601, 965.8937516873139, 1012.1649639047815, 9710.563024663767, 9940.204783617293, 10050.145737612385, 10067.395956242648, 10276.177905767521, 400.4353861055897, 400.6592126947779, 400.88173988672827, 402.9637332640018, 435.17099924643605, 5364.463553644604, 5597.944020559824, 5627.493525582635, 5663.414244011683, 5679.545636349082, 369834.0, 373309.0, 374963.0, 376301.0, 402291.0, 75541.0, 76227.61886190645, 78000.21999780044, 80944.59527702324, 81966.59016704997, 1139.3904261220373, 1153.8211577205548, 1186.821976703484, 1189.7739429508538, 1191.2495128069434, 13941.093828901088, 14583.270836457923, 14871.256437178314, 15306.23468826532, 15546.689066218838, 32834.50748238826, 33082.17294567655, 33338.0, 33391.1652208687, 35637.64362356343, 43844.78077609719, 44737.0, 45261.32108018448, 45661.77169114133, 46009.77931544893, 8954.417962832395, 9324.300677449082, 9378.5779639915, 9421.246300296098, 9434.29242806806, 10919.39943303126, 13395.330233488092, 16609.916950415172, 16895.577610559834, 16971.830281697024, 10340.510151474116, 11556.479958401724, 11867.109966752356, 13852.515161969282, 14390.280485975869, 13407.597772066854, 13652.795208071688, 13868.098573592684, 14064.929675351557, 14174.503892363718, 12762.42569084412, 13728.450861965808, 13989.510367137102, 14218.431262749375, 14322.355494002586, 8975.192232699088, 9031.322650801085, 9147.542622868963, 9175.908240917772, 9215.815683686424, 10059.044390782863, 10155.796884062425, 11650.88349116532, 14457.0, 14997.475088371855], "unit": "ms", "name": "jquery.html", "value": 8272.096557583345}, {"lowerIsBetter": false, "replicates": [1353.4045020191109, 1465.6848777512835, 1536.7848501209828, 1666.5083800278917, 1778.1287169287045, 6511.446527045201, 7154.35610795029, 7401.925980740198, 7403.62981850908, 7409.333160015598, 7231.963840180805, 7248.383887369567, 7291.343779059884, 7293.7082516699265, 7298.343149116578, 1934.3906669399164, 1970.3202395173641, 2159.600473912323, 2172.598069357174, 2175.760666326703, 2172.728408948881, 2246.9101235950625, 2249.572581209573, 2250.2799104286637, 2251.8536295140843, 2124.2352753008904, 2163.491579478821, 2168.577127460146, 2169.1865550418593, 2169.3166652504488, 1926.5472613935715, 1966.5378636020453, 1967.1442922328833, 1968.8523360748002, 2161.221960094365, 2187.147012665062, 2237.2505210754416, 2241.3388050525136, 2242.988785056081, 2243.4839986802963, 7186.820329491752, 7326.853462930765, 7327.9267207327775, 7330.633468326562, 7333.156686981012, 4401.207782599131, 4474.105178964221, 4510.0979804039325, 4511.954880451219, 4511.977440112812, 2963.7036296370406, 2996.5654980027994, 2998.595189649391, 2999.4151140527606, 3000.2799328161304, 978.3933960944261, 980.2990861533966, 1002.4286156890576, 1006.1397505133152, 1039.7608550033458, 9622.903770962272, 9625.229981601455, 9633.421994680342, 9638.132568068837, 9683.90316096837, 3992.540857801332, 4023.8591649292134, 4071.368937814584, 4075.1645912587846, 4084.346504559256, 8378.0, 8404.789880253042, 8410.537420441811, 8413.915860841313, 8432.198941100585, 4534.093181363674, 4548.113117942035, 4575.679702420799, 4576.519465456146, 4581.404417425713, 4093.8771836844944, 4098.426220329156, 4100.2414553307135, 4101.179764047202, 4101.938470922939, 3546.4148415511154, 3550.5029295898594, 3555.0, 3588.2823435313044, 3622.927541449209, 1196.7785959597502, 1200.687821166503, 1211.249025604131, 1222.9816552751715, 1236.2150034727833, 1078.1428764132534, 1137.2664631312757, 1340.9396577154052, 1380.1167252958114, 1381.4681347681214, 7039.54242974205, 7081.575105493584, 7089.0, 7094.858102838018, 7106.786796396116, 439.73396095362483, 455.45345585297116, 456.3907183909518, 457.3071796228716, 460.4796579864731, 5318.069337865858, 5387.0841956867425, 5433.728313584384, 5553.333599968029, 5849.093390524476, 8530.957345213359, 8759.386842921062, 8876.112388761072, 8928.15182557656, 8937.910620893837, 8359.205875441823, 8664.350173736995, 8670.306375489945, 8784.516851573097, 8791.34064945119, 6634.336566343423, 6643.069970204176, 6667.533272670867, 6684.766033188815, 6715.39561439463, 6889.689963951534, 6956.756513522205, 6967.198772141066, 6995.0, 7015.6842942066705, 7109.431245500451, 7589.0, 7851.05787305527, 7859.646315915912, 7897.4076944230565, 7794.415418843723, 7862.095858976291, 7927.0, 8003.19968003195, 8177.67289308421, 6876.793696189123, 6942.132233470817, 6954.408875245661, 6955.408790252885, 6969.1985421677155, 6861.1080559526945, 7078.327558881898, 7149.7497587584185, 7168.677409516688, 7188.5327453715345, 6604.5046621502615, 6697.665116744241, 6723.5293529452465, 6735.966320168368, 6841.726330946706, 6547.836304092245, 6622.569532980341, 6628.5691430056895, 6638.734450621921, 6741.662916854236, 6447.774327898689, 6538.378854008862, 6548.541602087998, 6567.802965911031, 6590.176227971504, 6244.875102498016, 6257.78097766576, 6261.68691565429, 6263.185785847811, 6266.655333956676, 6229.813105606839, 6240.375962403905, 6246.750129994749, 6246.781362652286, 6329.90505142414], "unit": "ms", "name": "mootools.html", "value": 4193.5909505012005}, {"lowerIsBetter": false, "replicates": [325.1027165024532, 327.0874260812334, 327.6608709985166, 334.17958910873824, 336.91577105723576, 5929.703514824258, 5931.080682494209, 5972.641641501513, 5986.982213023785, 5989.3112292086425, 5628.296462942132, 5707.600467967244, 5798.188253644493, 5899.380565040673, 5902.881942361161, 4571.725696458207, 4575.565321294472, 4587.0, 4591.678582499209, 4602.907941841161, 4302.182585308781, 4584.17484852728, 4585.128825523157, 4587.908241835161, 4588.288815233627, 4340.52254252032, 4409.933850992237, 4531.7960691768785, 4545.227311357061, 4556.316552517133, 4513.526079761644, 4514.142312960527, 4523.525029871866, 4525.524819893897, 4541.0, 3981.1042515433796, 3985.123272879962, 3987.2424239394422, 3992.241474119937, 3999.42008408782, 5530.557555395599, 5623.409541998113, 5624.6625202487985, 5626.043572592669, 5628.971855140739, 5253.133233016548, 5306.204069389584, 5308.469153084699, 5315.574754019669, 5317.8936421271355, 6198.194234749454, 6224.066390041485, 6252.531060170505, 6261.749530018794, 6263.1544741459775, 4445.355423463612, 4448.221561226805, 4452.710573812724, 4457.064016556495, 4458.063806600618, 6316.210473690789, 6440.5491615586925, 6474.708638111297, 6477.83805404864, 6488.188976377953, 4537.6143027843, 4537.909241815211, 4545.545445455428, 4548.431446069241, 4553.931691024637, 4594.839180628662, 4598.0, 4602.470715867718, 4610.746408947473, 4616.376789133424, 5273.235380869829, 5277.815276465382, 5279.498447647467, 5285.0, 5296.602754793406, 6098.817035488943, 6259.217597800275, 6298.7795427160745, 6308.842278943063, 6312.810615681537, 1554.0, 1587.8332775058452, 1588.356715530212, 1588.610790356347, 1589.4913627639276, 1047.512906498482, 1057.27048336649, 1061.2783307351076, 1063.2132222155549, 1083.247143235444, 6047.667378294148, 6053.970824959767, 6054.636721796706, 6057.454829065406, 6067.24159480065, 6438.163038804925, 6447.967760161263, 6448.226212854487, 6455.160829092282, 6483.222013358333, 5932.5550583705535, 6038.5772995889865, 6041.154238406627, 6044.24446944132, 6049.304330002018, 3434.4676575130893, 3496.4056110461283, 3505.1237190702323, 3507.035565219534, 3513.4554144107706, 6664.100346453264, 6676.26561078281, 6737.191537015589, 6753.3921947025, 6765.898511522331, 6511.674416279167, 6678.699458524378, 6679.131712877295, 6680.0, 6685.231198412148, 6753.898691519631, 6759.493038022168, 6764.8985265222045, 6765.255821859591, 6771.187457505131, 6496.512761542808, 6502.284748677736, 6504.577202481823, 6508.316626754312, 6515.087887695821, 6282.623042617458, 6431.260405053479, 6438.163038804925, 6441.67791610427, 6446.709898054505, 6757.493188011017, 6759.357861003196, 6760.290169532325, 6762.695678694372, 6768.763093291711, 4477.910441791081, 4478.059607482465, 4480.484744254452, 4485.686001979961, 4488.4165058543485, 6303.716332764945, 6431.581947173606, 6450.225972883284, 6451.322611125952, 6464.321246269262, 6305.5270854687, 6317.526185536195, 6337.334579869047, 6340.795248902694, 6345.0482427636225, 6258.374162583706, 6286.339934306832, 6293.244810622755, 6295.937040629535, 6311.463525600376, 6080.48315893154, 6188.721507532082, 6212.006079027515, 6226.159468471879, 6237.313895471585, 6350.872982540416, 6354.618722876642, 6361.236651601837, 6383.0, 6383.042543618309, 6217.502599792097, 6229.283632382153, 6231.9688401557705, 6253.3121356651645, 6257.78097766576], "unit": "ms", "name": "prototype.html", "value": 4752.134243141974}, {"lowerIsBetter": false, "replicates": [783.2911215350108, 846.9534175620338, 864.8486514859906, 867.3798234262503, 869.7651634058808, 13915.930420347897, 14237.85762142377, 14238.145711257332, 14254.287285635728, 14265.928670356647, 10826.025657690807, 13217.678232176802, 13300.667483312922, 13329.200247985127, 13335.53325633603, 670.684778154268, 809.8096947217399, 821.5522540215567, 824.4146655874337, 825.4799476329904, 821.4003777242616, 821.5768879027306, 827.3091968206555, 828.2752591482453, 828.883956246126, 710.4742490557003, 719.9460040496957, 859.2910848549972, 866.1901122450497, 866.9609867555976, 832.3466079127886, 859.2181115185183, 860.7761981884723, 860.832137733136, 861.0743450790362, 632.7405763636887, 635.7552342348183, 637.3976592120448, 639.5842702243532, 639.7153266796278, 13355.666108347272, 13446.991475639366, 13540.458381664721, 13557.457701691921, 13568.118072325366, 12230.327331996737, 12594.937025314906, 12806.743865122646, 12812.0, 12981.091323607352, 10436.686899393031, 10437.895621043768, 10450.634227801991, 10483.213758968108, 10638.148948084212, 3617.0, 3624.130208749881, 3669.94495082574, 3708.8145592720257, 3737.4789966245203, 45993.31010034852, 46028.0, 46418.0, 46472.53527464716, 47255.746982771714, 10028.69913902584, 10061.949690251502, 10095.697129086138, 10198.286119971532, 10292.279540432248, 18061.367852125113, 18077.09614519269, 18184.36354727578, 18213.0, 18240.63518729618, 7391.2978267064545, 7610.961945190239, 7615.619219039026, 7618.200088990576, 7674.0, 4291.54938731435, 4436.689431739812, 4455.75493347869, 4493.752843593568, 4613.0543238636, 3041.467743144985, 3079.2148002259282, 3086.382723455318, 3086.9504368514813, 3088.6139232595924, 542.4521233554138, 549.0419218463727, 554.6866020698293, 559.580314763927, 559.960802743804, 524.6851888866726, 535.0155713487202, 655.0730716036754, 656.8719099775593, 674.305465370669, 7922.7227047053075, 8296.253337199681, 8312.33501319893, 8385.119562445856, 8431.494110353398, 603.2670305578743, 611.2420598457969, 612.935641757618, 633.6246095448978, 647.1231481342807, 3766.1761701406754, 3961.267165574378, 3972.6226008529143, 4043.0, 4079.551249362568, 57566.7121664389, 58301.0, 58555.0, 58723.0, 58894.116588251214, 51575.742121289906, 52046.47953520492, 52429.0, 52479.0, 52679.0, 45745.31382029272, 46464.76767616208, 46685.06629867384, 47088.999999999316, 47458.28812567814, 8249.917500824915, 8285.83428331442, 8401.789955250923, 8616.310695144499, 8659.220670139717, 35020.64979350276, 35692.0, 36123.81938090398, 36174.8191259042, 36394.27211455809, 42616.14767704691, 42675.3598696026, 46540.53459465497, 46876.531234687216, 46906.0, 10032.347897386646, 10091.848622270818, 10257.487125643836, 10367.740806479898, 10890.61882834097, 10614.89385106139, 10674.46627668598, 10811.6215932442, 10851.240413171317, 11061.225714199929, 10365.792684146125, 10603.787924241626, 10847.0, 10928.289661172317, 10932.344059356465, 10173.491325433846, 10383.896161038292, 10503.422311772925, 10847.67456976292, 10851.891481085087, 9765.755856103655, 10246.6413675521, 10324.122449591869, 10369.688909332732, 10557.20820938448, 8647.956760216159, 8685.088065753005, 8755.562221889008, 8857.291416686521, 8984.59569319369, 8391.790205244917, 8588.699395521127, 8868.423552469068, 9176.311776616914, 9204.677836275698], "unit": "ms", "name": "yui.html", "value": 6207.114831353832}], "name": "dromaeo_css", "value": 6893.111704644664}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 112.0, 104.0, 109.0, 109.0, 111.0, 99.0, 108.0, 110.0, 101.0], "unit": "ms", "name": "ai-astar", "value": 107.1}, {"lowerIsBetter": true, "replicates": [147.0, 122.0, 154.0, 168.0, 126.0, 147.0, 145.0, 124.0, 159.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.6}, {"lowerIsBetter": true, "replicates": [166.0, 167.0, 168.0, 167.0, 169.0, 167.0, 166.0, 167.0, 167.0, 167.0], "unit": "ms", "name": "audio-dft", "value": 167.1}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 84.0, 96.0, 70.0, 71.0, 72.0, 106.0, 93.0, 70.0], "unit": "ms", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 138.0, 93.0, 94.0, 93.0, 138.0, 92.0, 93.0, 138.0], "unit": "ms", "name": "audio-oscillator", "value": 106.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 60.0, 58.0, 60.0, 59.0, 59.0, 66.0, 57.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 59.2}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 68.0, 69.0, 68.0, 68.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 86.0, 82.0, 83.0, 84.0, 85.0, 86.0, 84.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [123.0, 117.0, 113.0, 110.0, 120.0, 118.0, 113.0, 124.0, 129.0, 118.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.5}, {"lowerIsBetter": true, "replicates": [148.0, 141.0, 146.0, 154.0, 149.0, 139.0, 147.0, 145.0, 147.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.1}, {"lowerIsBetter": true, "replicates": [71.0, 67.0, 67.0, 66.0, 66.0, 68.0, 66.0, 65.0, 65.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1495.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [192.4557351809084], "unit": "score", "name": "Richards", "value": 183.42919199999997}, {"lowerIsBetter": false, "replicates": [194.66614755693985], "unit": "score", "name": "DeltaBlue", "value": 339.6481659999999}, {"lowerIsBetter": false, "replicates": [284.6569883290635], "unit": "score", "name": "Encrypt", "value": 935.093853}, {"lowerIsBetter": false, "replicates": [4995.024875621891], "unit": "score", "name": "Decrypt", "value": 53.289224103585696}, {"lowerIsBetter": false, "replicates": [1101.3215859030836], "unit": "score", "name": "RayTrace", "value": 671.910012}, {"lowerIsBetter": false, "replicates": [781.8608287724785], "unit": "score", "name": "Earley", "value": 852.4061770000001}, {"lowerIsBetter": false, "replicates": [12231.707317073171], "unit": "score", "name": "Boyer", "value": 54.4865064805583}, {"lowerIsBetter": false, "replicates": [25871.79487179487], "unit": "score", "name": "RegExp", "value": 35.21151139742318}, {"lowerIsBetter": false, "replicates": [564.9717514124294], "unit": "score", "name": "Splay", "value": 144.23906999999997}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20873.85237112152}]} 03:09:45 INFO - RETURN: dromaeo_css: 6893.11 03:09:45 INFO - RETURN: kraken: 1495.70 03:09:45 INFO - RETURN: v8_7: 20873.85 03:09:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "20873.85"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1495.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6893.11"}}} 03:09:46 INFO - Return code: 0 03:09:46 INFO - # TBPL SUCCESS # 03:09:46 INFO - Running post-action listener: _resource_record_post_action 03:09:46 INFO - Running post-run listener: _resource_record_post_run 03:09:47 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 0; Write bytes: 498565120; Read time: 0; Write time: 482524 03:09:47 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 216907776; Read time: 0; Write time: 278440 03:09:47 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 281174016; Read time: 0; Write time: 204044 03:09:47 INFO - Running post-run listener: _upload_blobber_files 03:09:47 INFO - Blob upload gear active. 03:09:47 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:09:47 INFO - Copying logs to upload dir... 03:09:47 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1271.972014 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-11-23 03:09:46.481224) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 03:09:46.484315) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1448275443.503974-1928316655 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/of9qwaCPTcaUZahEmOS9Ew/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009860 build_url: 'https://queue.taskcluster.net/v1/task/of9qwaCPTcaUZahEmOS9Ew/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-23 03:09:46.535023) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 03:09:46.535330) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1448275443.503974-1928316655 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004610 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 03:09:46.585456) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 03:09:46.585753) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 03:09:46.586038) ========= ========= Total master_lag: 0.23 =========