builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1448160937.58 results: success (0) buildid: 20151121173001 builduid: 634862c797a24b42a720ffd0b33da41d revision: 7f501ebf62efdfebc32f23ff7be90edd824bce01 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-21 18:55:37.583303) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-21 18:55:37.583689) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-21 18:55:37.583988) ========= 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=e10134013339c31d8d0c4708000001d6-1448148779.491272-1737342252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006592 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-21 18:55:37.623283) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-21 18:55:37.623628) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-21 18:55:37.674432) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 18:55:37.674717) ========= 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=e10134013339c31d8d0c4708000001d6-1448148779.491272-1737342252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.010675 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 18:55:37.724785) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-21 18:55:37.725073) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-21 18:55:37.725448) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 18:55:37.725743) ========= 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=e10134013339c31d8d0c4708000001d6-1448148779.491272-1737342252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-21 18:55:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.8M=0s 2015-11-21 18:55:38 (39.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163460 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 18:55:37.901013) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 18:55:37.901330) ========= 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=e10134013339c31d8d0c4708000001d6-1448148779.491272-1737342252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.093086 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 18:55:38.005630) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-21 18:55:38.005963) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 7f501ebf62efdfebc32f23ff7be90edd824bce01 --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/b2g-inbound --rev 7f501ebf62efdfebc32f23ff7be90edd824bce01 --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=e10134013339c31d8d0c4708000001d6-1448148779.491272-1737342252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-21 18:55:38,301 truncating revision to first 12 chars 2015-11-21 18:55:38,301 Setting DEBUG logging. 2015-11-21 18:55:38,301 attempt 1/10 2015-11-21 18:55:38,301 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/7f501ebf62ef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-21 18:55:39,142 unpacking tar archive at: b2g-inbound-7f501ebf62ef/testing/mozharness/ program finished with exit code 0 elapsedTime=1.150641 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-21 18:55:39.169364) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-21 18:55:39.169657) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-21 18:55:39.178489) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-21 18:55:39.178736) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-21 18:55:39.179075) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-11-21 18:55:39.179367) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-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', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-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=e10134013339c31d8d0c4708000001d6-1448148779.491272-1737342252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:55:39 INFO - MultiFileLogger online at 20151121 18:55:39 in /builds/slave/test-pgo 18:55:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 18:55:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:55:39 INFO - {'append_to_log': False, 18:55:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:55:39 INFO - 'blob_upload_branch': 'B2G-Inbound', 18:55:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:55:39 INFO - 'branch': 'B2G-Inbound', 18:55:39 INFO - 'buildbot_json_path': 'buildprops.json', 18:55:39 INFO - 'config_files': ('talos/linux_config.py',), 18:55:39 INFO - 'default_actions': ('clobber', 18:55:39 INFO - 'read-buildbot-config', 18:55:39 INFO - 'download-and-extract', 18:55:39 INFO - 'populate-webroot', 18:55:39 INFO - 'create-virtualenv', 18:55:39 INFO - 'install', 18:55:39 INFO - 'run-tests'), 18:55:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:55:39 INFO - 'download_minidump_stackwalk': True, 18:55:39 INFO - 'download_symbols': 'ondemand', 18:55:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:55:39 INFO - 'tooltool.py': '/tools/tooltool.py', 18:55:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:55:39 INFO - '/tools/misc-python/virtualenv.py')}, 18:55:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:55:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:55:39 INFO - 'installer_path': 'installer.exe', 18:55:39 INFO - 'log_level': 'info', 18:55:39 INFO - 'log_name': 'talos', 18:55:39 INFO - 'log_to_console': True, 18:55:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:55:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:55:39 INFO - 'opt_config_files': (), 18:55:39 INFO - 'pip_index': False, 18:55:39 INFO - 'sps_profile': False, 18:55:39 INFO - 'sps_profile_interval': 0, 18:55:39 INFO - 'suite': 'dromaeojs', 18:55:39 INFO - 'system_bits': '64', 18:55:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:55:39 INFO - 'title': 'talos-linux64-ix-023', 18:55:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:55:39 INFO - 'use_talos_json': True, 18:55:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:55:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:55:39 INFO - 'work_dir': 'build'} 18:55:39 INFO - ##### 18:55:39 INFO - ##### Running clobber step. 18:55:39 INFO - ##### 18:55:39 INFO - Running pre-action listener: _resource_record_pre_action 18:55:39 INFO - Running main action method: clobber 18:55:39 INFO - rmtree: /builds/slave/test-pgo/build 18:55:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:55:44 INFO - Running post-action listener: _resource_record_post_action 18:55:44 INFO - ##### 18:55:44 INFO - ##### Running read-buildbot-config step. 18:55:44 INFO - ##### 18:55:44 INFO - Running pre-action listener: _resource_record_pre_action 18:55:44 INFO - Running main action method: read_buildbot_config 18:55:44 INFO - Using buildbot properties: 18:55:44 INFO - { 18:55:44 INFO - "properties": { 18:55:44 INFO - "buildnumber": 992, 18:55:44 INFO - "product": "firefox", 18:55:44 INFO - "script_repo_revision": "production", 18:55:44 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 18:55:44 INFO - "repository": "", 18:55:44 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 18:55:44 INFO - "buildid": "20151121173001", 18:55:44 INFO - "slavename": "talos-linux64-ix-023", 18:55:44 INFO - "pgo_build": "True", 18:55:44 INFO - "basedir": "/builds/slave/test-pgo", 18:55:44 INFO - "project": "", 18:55:44 INFO - "platform": "ubuntu64_hw", 18:55:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:55:44 INFO - "slavebuilddir": "test", 18:55:44 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 18:55:44 INFO - "branch": "b2g-inbound", 18:55:44 INFO - "repo_path": "integration/b2g-inbound", 18:55:44 INFO - "stage_platform": "linux64-pgo", 18:55:44 INFO - "builduid": "634862c797a24b42a720ffd0b33da41d", 18:55:44 INFO - "revision": "7f501ebf62efdfebc32f23ff7be90edd824bce01" 18:55:44 INFO - }, 18:55:44 INFO - "sourcestamp": { 18:55:44 INFO - "repository": "", 18:55:44 INFO - "hasPatch": false, 18:55:44 INFO - "project": "", 18:55:44 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 18:55:44 INFO - "changes": [ 18:55:44 INFO - { 18:55:44 INFO - "category": null, 18:55:44 INFO - "files": [ 18:55:44 INFO - { 18:55:44 INFO - "url": null, 18:55:44 INFO - "name": "https://queue.taskcluster.net/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 18:55:44 INFO - } 18:55:44 INFO - ], 18:55:44 INFO - "repository": "", 18:55:44 INFO - "rev": "7f501ebf62efdfebc32f23ff7be90edd824bce01", 18:55:44 INFO - "who": "sendchange", 18:55:44 INFO - "when": 1448160925, 18:55:44 INFO - "number": 6692831, 18:55:44 INFO - "comments": "", 18:55:44 INFO - "project": "", 18:55:44 INFO - "at": "Sat 21 Nov 2015 18:55:25", 18:55:44 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 18:55:44 INFO - "revlink": "", 18:55:44 INFO - "properties": [ 18:55:44 INFO - [ 18:55:44 INFO - "buildid", 18:55:44 INFO - "20151121173001", 18:55:44 INFO - "Change" 18:55:44 INFO - ], 18:55:44 INFO - [ 18:55:44 INFO - "builduid", 18:55:44 INFO - "634862c797a24b42a720ffd0b33da41d", 18:55:44 INFO - "Change" 18:55:44 INFO - ], 18:55:44 INFO - [ 18:55:44 INFO - "pgo_build", 18:55:44 INFO - "True", 18:55:44 INFO - "Change" 18:55:44 INFO - ] 18:55:44 INFO - ], 18:55:44 INFO - "revision": "7f501ebf62efdfebc32f23ff7be90edd824bce01" 18:55:44 INFO - } 18:55:44 INFO - ], 18:55:44 INFO - "revision": "7f501ebf62efdfebc32f23ff7be90edd824bce01" 18:55:44 INFO - } 18:55:44 INFO - } 18:55:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 18:55:44 INFO - Running post-action listener: _resource_record_post_action 18:55:44 INFO - ##### 18:55:44 INFO - ##### Running download-and-extract step. 18:55:44 INFO - ##### 18:55:44 INFO - Running pre-action listener: _resource_record_pre_action 18:55:44 INFO - Running main action method: download_and_extract 18:55:44 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:44 INFO - https://queue.taskcluster.net/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:55:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/test_packages.json 18:55:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/test_packages.json 18:55:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 18:55:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 18:55:45 INFO - Downloaded 1302 bytes. 18:55:45 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 18:55:45 INFO - Using the following test package requirements: 18:55:45 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:55:45 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:55:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:55:45 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:55:45 INFO - u'jsshell-linux-x86_64.zip'], 18:55:45 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:55:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:55:45 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:55:45 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:55:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:55:45 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:55:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:55:45 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:55:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:55:45 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:55:45 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:55:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:55:45 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:45 INFO - https://queue.taskcluster.net/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:55:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:55:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:55:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:55:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:55:46 INFO - Downloaded 22522888 bytes. 18:55:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 18:55:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:55:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:55:47 INFO - Return code: 0 18:55:47 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:47 INFO - https://queue.taskcluster.net/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:55:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:55:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:55:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:55:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:55:50 INFO - Downloaded 22522888 bytes. 18:55:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 18:55:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:55:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:55:51 INFO - Return code: 0 18:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:51 INFO - https://queue.taskcluster.net/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:55:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:55:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:55:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:55:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:55:52 INFO - Downloaded 11130997 bytes. 18:55:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 18:55:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:55:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 18:55:52 INFO - Return code: 0 18:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:52 INFO - https://queue.taskcluster.net/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:55:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:55:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:55:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:55:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:55:54 INFO - Downloaded 57439841 bytes. 18:55:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:55:54 INFO - mkdir: /builds/slave/test-pgo/properties 18:55:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:55:54 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:55:54 INFO - Contents: 18:55:54 INFO - build_url:https://queue.taskcluster.net/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:55:54 INFO - Running post-action listener: _resource_record_post_action 18:55:54 INFO - Running post-action listener: set_extra_try_arguments 18:55:54 INFO - ##### 18:55:54 INFO - ##### Running populate-webroot step. 18:55:54 INFO - ##### 18:55:54 INFO - Running pre-action listener: _resource_record_pre_action 18:55:54 INFO - Running main action method: populate_webroot 18:55:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:55:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:55:54 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:55:54 INFO - '../fennec_ids.txt'], 18:55:54 INFO - 'tests': ['tcheck2']}, 18:55:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:55:54 INFO - '--tppagecycles', 18:55:54 INFO - '7'], 18:55:54 INFO - 'tests': ['tsvgm']}}, 18:55:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:55:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:55:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:55:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:55:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:55:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:55:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:55:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:54 INFO - 'talos_options': ['--e10s'], 18:55:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:55:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:54 INFO - 'tests': ['damp', 'tps']}, 18:55:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:54 INFO - 'talos_options': ['--e10s'], 18:55:54 INFO - 'tests': ['damp', 'tps']}, 18:55:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:55:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:55:54 INFO - 'other': {'tests': ['a11yr', 18:55:54 INFO - 'ts_paint', 18:55:54 INFO - 'tpaint', 18:55:54 INFO - 'sessionrestore', 18:55:54 INFO - 'sessionrestore_no_auto_restore']}, 18:55:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:55:54 INFO - 'tests': ['a11yr', 18:55:54 INFO - 'ts_paint', 18:55:54 INFO - 'tpaint', 18:55:54 INFO - 'sessionrestore', 18:55:54 INFO - 'sessionrestore_no_auto_restore']}, 18:55:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:55:54 INFO - 'tests': ['a11yr', 18:55:54 INFO - 'ts_paint', 18:55:54 INFO - 'tpaint', 18:55:54 INFO - 'sessionrestore', 18:55:54 INFO - 'sessionrestore_no_auto_restore']}, 18:55:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:55:54 INFO - 'tests': ['a11yr', 18:55:54 INFO - 'ts_paint', 18:55:54 INFO - 'tpaint', 18:55:54 INFO - 'sessionrestore', 18:55:54 INFO - 'sessionrestore_no_auto_restore']}, 18:55:54 INFO - 'other_l64': {'tests': ['a11yr', 18:55:54 INFO - 'ts_paint', 18:55:54 INFO - 'tpaint', 18:55:54 INFO - 'sessionrestore', 18:55:54 INFO - 'sessionrestore_no_auto_restore']}, 18:55:54 INFO - 'other_nol64': {'tests': ['a11yr', 18:55:54 INFO - 'ts_paint', 18:55:54 INFO - 'tpaint', 18:55:54 INFO - 'sessionrestore', 18:55:54 INFO - 'sessionrestore_no_auto_restore']}, 18:55:54 INFO - 'svgr': {'tests': ['tsvgx', 18:55:54 INFO - 'tsvgr_opacity', 18:55:54 INFO - 'tart', 18:55:54 INFO - 'tscrollx', 18:55:54 INFO - 'cart']}, 18:55:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:55:54 INFO - 'tests': ['tsvgx', 18:55:54 INFO - 'tsvgr_opacity', 18:55:54 INFO - 'tart', 18:55:54 INFO - 'tscrollx', 18:55:54 INFO - 'cart']}, 18:55:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:54 INFO - 'tests': ['tp5o']}, 18:55:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:54 INFO - 'talos_options': ['--e10s'], 18:55:54 INFO - 'tests': ['tp5o']}, 18:55:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:54 INFO - 'talos_options': ['--xperf_path', 18:55:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:55:54 INFO - 'tests': ['tp5n']}, 18:55:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:54 INFO - 'talos_options': ['--e10s', 18:55:54 INFO - '--xperf_path', 18:55:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:55:54 INFO - 'tests': ['tp5n']}}, 18:55:54 INFO - 'talos.zip': {'path': '', 18:55:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:55:54 INFO - Running post-action listener: _resource_record_post_action 18:55:54 INFO - ##### 18:55:54 INFO - ##### Running create-virtualenv step. 18:55:54 INFO - ##### 18:55:54 INFO - Running pre-action listener: _resource_record_pre_action 18:55:54 INFO - Running main action method: create_virtualenv 18:55:54 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:55:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 18:55:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:55:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:55:54 INFO - Using real prefix '/usr' 18:55:54 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:55:54 INFO - Installing distribute.............................................................................................................................................................................................done. 18:55:56 INFO - Installing pip.................done. 18:55:56 INFO - Return code: 0 18:55:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:55: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')]} 18:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55: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')]} 18:55:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:56 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 0x7fa2dad3ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bce7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c12d70>, '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 0x2c13b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c13fb0>, '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': 'e10134013339c31d8d0c4708000001d6-1448148779.491272-1737342252', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:55:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 18:55:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:55:56 INFO - Using env: {'DISPLAY': ':0', 18:55:56 INFO - 'HOME': '/home/cltbld', 18:55:56 INFO - 'LANG': 'en_US.UTF-8', 18:55:56 INFO - 'LANGUAGE': 'en_US:en', 18:55:56 INFO - 'LOGNAME': 'cltbld', 18:55:56 INFO - 'MAIL': '/var/mail/cltbld', 18:55:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:56 INFO - 'MOZ_NO_REMOTE': '1', 18:55:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:56 INFO - 'NO_EM_RESTART': '1', 18:55:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:55:56 INFO - 'PWD': '/builds/slave/test-pgo', 18:55:56 INFO - 'SHELL': '/bin/bash', 18:55:56 INFO - 'SHLVL': '1', 18:55:56 INFO - 'TERM': 'linux', 18:55:56 INFO - 'TMOUT': '86400', 18:55:56 INFO - 'USER': 'cltbld', 18:55:56 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448148779.491272-1737342252', 18:55:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:56 INFO - '_': '/tools/buildbot/bin/python'} 18:55:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:55:56 INFO - Cleaning up... 18:55:56 INFO - Return code: 0 18:55:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:55: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')]} 18:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55: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')]} 18:55:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:56 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 0x7fa2dad3ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bce7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c12d70>, '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 0x2c13b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c13fb0>, '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': 'e10134013339c31d8d0c4708000001d6-1448148779.491272-1737342252', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:55:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 18:55:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:55:56 INFO - Using env: {'DISPLAY': ':0', 18:55:56 INFO - 'HOME': '/home/cltbld', 18:55:56 INFO - 'LANG': 'en_US.UTF-8', 18:55:56 INFO - 'LANGUAGE': 'en_US:en', 18:55:56 INFO - 'LOGNAME': 'cltbld', 18:55:56 INFO - 'MAIL': '/var/mail/cltbld', 18:55:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:56 INFO - 'MOZ_NO_REMOTE': '1', 18:55:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:56 INFO - 'NO_EM_RESTART': '1', 18:55:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:55:56 INFO - 'PWD': '/builds/slave/test-pgo', 18:55:56 INFO - 'SHELL': '/bin/bash', 18:55:56 INFO - 'SHLVL': '1', 18:55:56 INFO - 'TERM': 'linux', 18:55:56 INFO - 'TMOUT': '86400', 18:55:56 INFO - 'USER': 'cltbld', 18:55:56 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448148779.491272-1737342252', 18:55:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:56 INFO - '_': '/tools/buildbot/bin/python'} 18:55:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:57 INFO - Downloading/unpacking psutil>=0.7.1 18:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:58 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 18:55:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:55:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:55:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:55:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:55:59 INFO - Installing collected packages: psutil 18:55:59 INFO - Running setup.py install for psutil 18:55:59 INFO - building 'psutil._psutil_linux' extension 18:55:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:55:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:55:59 INFO - building 'psutil._psutil_posix' extension 18:55:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:55:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:55:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:55:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:55:59 INFO - Successfully installed psutil 18:55:59 INFO - Cleaning up... 18:56:00 INFO - Return code: 0 18:56:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:00 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 0x7fa2dad3ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bce7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c12d70>, '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 0x2c13b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c13fb0>, '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': 'e10134013339c31d8d0c4708000001d6-1448148779.491272-1737342252', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:56:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 18:56:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:56:00 INFO - Using env: {'DISPLAY': ':0', 18:56:00 INFO - 'HOME': '/home/cltbld', 18:56:00 INFO - 'LANG': 'en_US.UTF-8', 18:56:00 INFO - 'LANGUAGE': 'en_US:en', 18:56:00 INFO - 'LOGNAME': 'cltbld', 18:56:00 INFO - 'MAIL': '/var/mail/cltbld', 18:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:00 INFO - 'MOZ_NO_REMOTE': '1', 18:56:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:00 INFO - 'NO_EM_RESTART': '1', 18:56:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:56:00 INFO - 'PWD': '/builds/slave/test-pgo', 18:56:00 INFO - 'SHELL': '/bin/bash', 18:56:00 INFO - 'SHLVL': '1', 18:56:00 INFO - 'TERM': 'linux', 18:56:00 INFO - 'TMOUT': '86400', 18:56:00 INFO - 'USER': 'cltbld', 18:56:00 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448148779.491272-1737342252', 18:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:00 INFO - '_': '/tools/buildbot/bin/python'} 18:56:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:56:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:56:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:56:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:56:02 INFO - Installing collected packages: mozsystemmonitor 18:56:02 INFO - Running setup.py install for mozsystemmonitor 18:56:02 INFO - Successfully installed mozsystemmonitor 18:56:02 INFO - Cleaning up... 18:56:02 INFO - Return code: 0 18:56:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:02 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 0x7fa2dad3ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bce7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c12d70>, '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 0x2c13b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c13fb0>, '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': 'e10134013339c31d8d0c4708000001d6-1448148779.491272-1737342252', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:56:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 18:56:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:56:02 INFO - Using env: {'DISPLAY': ':0', 18:56:02 INFO - 'HOME': '/home/cltbld', 18:56:02 INFO - 'LANG': 'en_US.UTF-8', 18:56:02 INFO - 'LANGUAGE': 'en_US:en', 18:56:02 INFO - 'LOGNAME': 'cltbld', 18:56:02 INFO - 'MAIL': '/var/mail/cltbld', 18:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:02 INFO - 'MOZ_NO_REMOTE': '1', 18:56:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:02 INFO - 'NO_EM_RESTART': '1', 18:56:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:56:02 INFO - 'PWD': '/builds/slave/test-pgo', 18:56:02 INFO - 'SHELL': '/bin/bash', 18:56:02 INFO - 'SHLVL': '1', 18:56:02 INFO - 'TERM': 'linux', 18:56:02 INFO - 'TMOUT': '86400', 18:56:02 INFO - 'USER': 'cltbld', 18:56:02 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448148779.491272-1737342252', 18:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:02 INFO - '_': '/tools/buildbot/bin/python'} 18:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:02 INFO - Downloading/unpacking blobuploader==1.2.4 18:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:04 INFO - Downloading blobuploader-1.2.4.tar.gz 18:56:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:56:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:56:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:56:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:56:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:04 INFO - Downloading docopt-0.6.1.tar.gz 18:56:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:56:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:56:04 INFO - Installing collected packages: blobuploader, requests, docopt 18:56:04 INFO - Running setup.py install for blobuploader 18:56:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:56:05 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:56:05 INFO - Running setup.py install for requests 18:56:05 INFO - Running setup.py install for docopt 18:56:05 INFO - Successfully installed blobuploader requests docopt 18:56:05 INFO - Cleaning up... 18:56:05 INFO - Return code: 0 18:56:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:05 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 0x7fa2dad3ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bce7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c12d70>, '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 0x2c13b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c13fb0>, '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': 'e10134013339c31d8d0c4708000001d6-1448148779.491272-1737342252', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:56:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 18:56:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:56:05 INFO - Using env: {'DISPLAY': ':0', 18:56:05 INFO - 'HOME': '/home/cltbld', 18:56:05 INFO - 'LANG': 'en_US.UTF-8', 18:56:05 INFO - 'LANGUAGE': 'en_US:en', 18:56:05 INFO - 'LOGNAME': 'cltbld', 18:56:05 INFO - 'MAIL': '/var/mail/cltbld', 18:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:05 INFO - 'MOZ_NO_REMOTE': '1', 18:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:05 INFO - 'NO_EM_RESTART': '1', 18:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:56:05 INFO - 'PWD': '/builds/slave/test-pgo', 18:56:05 INFO - 'SHELL': '/bin/bash', 18:56:05 INFO - 'SHLVL': '1', 18:56:05 INFO - 'TERM': 'linux', 18:56:05 INFO - 'TMOUT': '86400', 18:56:05 INFO - 'USER': 'cltbld', 18:56:05 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448148779.491272-1737342252', 18:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:05 INFO - '_': '/tools/buildbot/bin/python'} 18:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:56:05 INFO - Running setup.py (path:/tmp/pip-ynsGgt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:56:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:56:05 INFO - Running setup.py (path:/tmp/pip-IEiA2V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:56:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:56:05 INFO - Running setup.py (path:/tmp/pip-4ybA8B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:56:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:56:05 INFO - Running setup.py (path:/tmp/pip-Cdhf9J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:56:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:56:06 INFO - Running setup.py (path:/tmp/pip-WlBPux-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:56:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:56:06 INFO - Running setup.py (path:/tmp/pip-Fe16JF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:56:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:56:06 INFO - Running setup.py (path:/tmp/pip-DwsBCK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:56:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:56:06 INFO - Running setup.py (path:/tmp/pip-P2BlS4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:56:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:56:06 INFO - Running setup.py (path:/tmp/pip-pbBLDt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:56:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:56:06 INFO - Running setup.py (path:/tmp/pip-EW3yHL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:56:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:56:06 INFO - Running setup.py (path:/tmp/pip-qap1Z_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:56:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:56:06 INFO - Running setup.py (path:/tmp/pip-3pruJ4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:56:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:56:06 INFO - Running setup.py (path:/tmp/pip-vGg5Uf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:56:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:56:06 INFO - Running setup.py (path:/tmp/pip-av7vKh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:56:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:56:06 INFO - Running setup.py (path:/tmp/pip-HWKvQE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:56:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:56:06 INFO - Running setup.py (path:/tmp/pip-lDG4Ku-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:56:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:56:06 INFO - Running setup.py (path:/tmp/pip-phGGwu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:56:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:56:06 INFO - Running setup.py install for manifestparser 18:56:07 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:56:07 INFO - Running setup.py install for mozcrash 18:56:07 INFO - Running setup.py install for mozdebug 18:56:07 INFO - Running setup.py install for mozdevice 18:56:07 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:56:07 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:56:07 INFO - Running setup.py install for mozfile 18:56:07 INFO - Running setup.py install for mozhttpd 18:56:07 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:56:07 INFO - Running setup.py install for mozinfo 18:56:07 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:56:07 INFO - Running setup.py install for mozInstall 18:56:07 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:56:07 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:56:07 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:56:07 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:56:07 INFO - Running setup.py install for mozleak 18:56:07 INFO - Running setup.py install for mozlog 18:56:08 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:56:08 INFO - Running setup.py install for moznetwork 18:56:08 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:56:08 INFO - Running setup.py install for mozprocess 18:56:08 INFO - Running setup.py install for mozprofile 18:56:08 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:56:08 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:56:08 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:56:08 INFO - Running setup.py install for mozrunner 18:56:08 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:56:08 INFO - Running setup.py install for mozscreenshot 18:56:08 INFO - Running setup.py install for moztest 18:56:08 INFO - Running setup.py install for mozversion 18:56:08 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:56:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:56:08 INFO - Cleaning up... 18:56:08 INFO - Return code: 0 18:56:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:56: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')]} 18:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56: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')]} 18:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56: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', '-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 0x7fa2dad3ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bce7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c12d70>, '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 0x2c13b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c13fb0>, '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': 'e10134013339c31d8d0c4708000001d6-1448148779.491272-1737342252', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:56:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 18:56:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:56:08 INFO - Using env: {'DISPLAY': ':0', 18:56:08 INFO - 'HOME': '/home/cltbld', 18:56:08 INFO - 'LANG': 'en_US.UTF-8', 18:56:08 INFO - 'LANGUAGE': 'en_US:en', 18:56:08 INFO - 'LOGNAME': 'cltbld', 18:56:08 INFO - 'MAIL': '/var/mail/cltbld', 18:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:08 INFO - 'MOZ_NO_REMOTE': '1', 18:56:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:08 INFO - 'NO_EM_RESTART': '1', 18:56:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:56:08 INFO - 'PWD': '/builds/slave/test-pgo', 18:56:08 INFO - 'SHELL': '/bin/bash', 18:56:08 INFO - 'SHLVL': '1', 18:56:08 INFO - 'TERM': 'linux', 18:56:08 INFO - 'TMOUT': '86400', 18:56:08 INFO - 'USER': 'cltbld', 18:56:08 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448148779.491272-1737342252', 18:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:08 INFO - '_': '/tools/buildbot/bin/python'} 18:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:56:08 INFO - Running setup.py (path:/tmp/pip-8fen7O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:56:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 18:56:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:56:09 INFO - Running setup.py (path:/tmp/pip-nl9XsK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:56:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:56:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:56:09 INFO - Running setup.py (path:/tmp/pip-tElLsZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:56:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 18:56:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:56:09 INFO - Running setup.py (path:/tmp/pip-gIjDaT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:56:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:56:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:56:09 INFO - Running setup.py (path:/tmp/pip-Kdc_YT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:56:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 18:56:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:56:09 INFO - Running setup.py (path:/tmp/pip-fxyQKU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:56:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 18:56:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:56:09 INFO - Running setup.py (path:/tmp/pip-Bgl6yi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:56:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 18:56:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:56:09 INFO - Running setup.py (path:/tmp/pip-ssUWNS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:56:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 18:56:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:56:09 INFO - Running setup.py (path:/tmp/pip-tD2kzU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:56:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 18:56:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:56:09 INFO - Running setup.py (path:/tmp/pip-OqBuMh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:56:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:56:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:56:09 INFO - Running setup.py (path:/tmp/pip-m8oUaH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:56:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 18:56:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:56:09 INFO - Running setup.py (path:/tmp/pip-0cAc3Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:56:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 18:56:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:56:09 INFO - Running setup.py (path:/tmp/pip-GeTLQO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:56:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 18:56:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:56:09 INFO - Running setup.py (path:/tmp/pip-jyWnXj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:56:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 18:56:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:56:09 INFO - Running setup.py (path:/tmp/pip-mKI_Qu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:56:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 18:56:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:56:10 INFO - Running setup.py (path:/tmp/pip-mAkeug-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:56:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 18:56:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:56:10 INFO - Running setup.py (path:/tmp/pip-qRtQSo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:56:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 18:56:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:56:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:56:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 18:56:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:56:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:56:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:56: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 18:56: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 18:56: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 18:56: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 18:56: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 18:56: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 18:56:11 INFO - Downloading blessings-1.5.1.tar.gz 18:56:11 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 18:56:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:56:11 INFO - Installing collected packages: blessings 18:56:11 INFO - Running setup.py install for blessings 18:56:12 INFO - Successfully installed blessings 18:56:12 INFO - Cleaning up... 18:56:12 INFO - Return code: 0 18:56:12 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:56:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:56:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:56:12 INFO - Reading from file tmpfile_stdout 18:56:12 INFO - Current package versions: 18:56:12 INFO - argparse == 1.2.1 18:56:12 INFO - blessings == 1.5.1 18:56:12 INFO - blobuploader == 1.2.4 18:56:12 INFO - docopt == 0.6.1 18:56:12 INFO - manifestparser == 1.1 18:56:12 INFO - mozInstall == 1.12 18:56:12 INFO - mozcrash == 0.16 18:56:12 INFO - mozdebug == 0.1 18:56:12 INFO - mozdevice == 0.47 18:56:12 INFO - mozfile == 1.2 18:56:12 INFO - mozhttpd == 0.7 18:56:12 INFO - mozinfo == 0.9 18:56:12 INFO - mozleak == 0.1 18:56:12 INFO - mozlog == 3.0 18:56:12 INFO - moznetwork == 0.27 18:56:12 INFO - mozprocess == 0.22 18:56:12 INFO - mozprofile == 0.27 18:56:12 INFO - mozrunner == 6.11 18:56:12 INFO - mozscreenshot == 0.1 18:56:12 INFO - mozsystemmonitor == 0.0 18:56:12 INFO - moztest == 0.7 18:56:12 INFO - mozversion == 1.4 18:56:12 INFO - psutil == 3.1.1 18:56:12 INFO - requests == 1.2.3 18:56:12 INFO - wsgiref == 0.1.2 18:56:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:56:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fa2dad3ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bce7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c12d70>, '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 0x2c13b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c13fb0>, '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': 'e10134013339c31d8d0c4708000001d6-1448148779.491272-1737342252', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:56:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 18:56:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:56:12 INFO - Using env: {'DISPLAY': ':0', 18:56:12 INFO - 'HOME': '/home/cltbld', 18:56:12 INFO - 'LANG': 'en_US.UTF-8', 18:56:12 INFO - 'LANGUAGE': 'en_US:en', 18:56:12 INFO - 'LOGNAME': 'cltbld', 18:56:12 INFO - 'MAIL': '/var/mail/cltbld', 18:56:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:12 INFO - 'MOZ_NO_REMOTE': '1', 18:56:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:12 INFO - 'NO_EM_RESTART': '1', 18:56:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:56:12 INFO - 'PWD': '/builds/slave/test-pgo', 18:56:12 INFO - 'SHELL': '/bin/bash', 18:56:12 INFO - 'SHLVL': '1', 18:56:12 INFO - 'TERM': 'linux', 18:56:12 INFO - 'TMOUT': '86400', 18:56:12 INFO - 'USER': 'cltbld', 18:56:12 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448148779.491272-1737342252', 18:56:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:12 INFO - '_': '/tools/buildbot/bin/python'} 18:56:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 18:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 18:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 18:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 18:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 18:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 18:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 18:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 18:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 18:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 18:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 18:56:12 INFO - Cleaning up... 18:56:12 INFO - Return code: 0 18:56:12 INFO - Running post-action listener: _resource_record_post_action 18:56:12 INFO - Running post-action listener: _start_resource_monitoring 18:56:12 INFO - Starting resource monitoring. 18:56:12 INFO - ##### 18:56:12 INFO - ##### Running install step. 18:56:12 INFO - ##### 18:56:12 INFO - Running pre-action listener: _resource_record_pre_action 18:56:12 INFO - Running main action method: install 18:56:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:56:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:56:12 INFO - Reading from file tmpfile_stdout 18:56:12 INFO - Detecting whether we're running mozinstall >=1.0... 18:56:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:56:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:56:12 INFO - Reading from file tmpfile_stdout 18:56:12 INFO - Output received: 18:56:12 INFO - Usage: mozinstall [options] installer 18:56:12 INFO - Options: 18:56:12 INFO - -h, --help show this help message and exit 18:56:12 INFO - -d DEST, --destination=DEST 18:56:12 INFO - Directory to install application into. [default: 18:56:12 INFO - "/builds/slave/test-pgo"] 18:56:12 INFO - --app=APP Application being installed. [default: firefox] 18:56:12 INFO - mkdir: /builds/slave/test-pgo/build/application 18:56:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 18:56:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 18:56:27 INFO - Reading from file tmpfile_stdout 18:56:27 INFO - Output received: 18:56:27 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:56:27 INFO - Running post-action listener: _resource_record_post_action 18:56:27 INFO - ##### 18:56:27 INFO - ##### Running run-tests step. 18:56:27 INFO - ##### 18:56:27 INFO - Running pre-action listener: _resource_record_pre_action 18:56:27 INFO - Running main action method: run_tests 18:56:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:56:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:56:27 INFO - Python 2.7.3 18:56:27 INFO - Return code: 0 18:56:27 INFO - grabbing minidump binary from tooltool 18:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:27 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 0x2c12d70>, '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 0x2c13b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c13fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:56:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 18:56:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:56:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:56:27 INFO - Return code: 0 18:56:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:56:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:56:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:56:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:56:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:56:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 18:56:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost 18:56:27 INFO - Using env: {'DISPLAY': ':0', 18:56:27 INFO - 'HOME': '/home/cltbld', 18:56:27 INFO - 'LANG': 'en_US.UTF-8', 18:56:27 INFO - 'LANGUAGE': 'en_US:en', 18:56:27 INFO - 'LOGNAME': 'cltbld', 18:56:27 INFO - 'MAIL': '/var/mail/cltbld', 18:56:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:56:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:56:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:27 INFO - 'MOZ_NO_REMOTE': '1', 18:56:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:56:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:27 INFO - 'NO_EM_RESTART': '1', 18:56:27 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:56:27 INFO - 'PWD': '/builds/slave/test-pgo', 18:56:27 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:56:27 INFO - 'SHELL': '/bin/bash', 18:56:27 INFO - 'SHLVL': '1', 18:56:27 INFO - 'TERM': 'linux', 18:56:27 INFO - 'TMOUT': '86400', 18:56:27 INFO - 'USER': 'cltbld', 18:56:27 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448148779.491272-1737342252', 18:56:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:27 INFO - '_': '/tools/buildbot/bin/python'} 18:56:27 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] with output_timeout 3600 18:56:27 INFO - mozversion INFO | application_buildid: 20151121173001 18:56:27 INFO - mozversion INFO | application_changeset: 7f501ebf62efdfebc32f23ff7be90edd824bce01 18:56:27 INFO - mozversion INFO | application_display_name: Nightly 18:56:27 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:56:27 INFO - mozversion INFO | application_name: Firefox 18:56:27 INFO - mozversion INFO | application_remotingname: firefox 18:56:27 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 18:56:27 INFO - mozversion INFO | application_vendor: Mozilla 18:56:27 INFO - mozversion INFO | application_version: 45.0a1 18:56:27 INFO - mozversion INFO | platform_buildid: 20151121173001 18:56:27 INFO - mozversion INFO | platform_changeset: 7f501ebf62efdfebc32f23ff7be90edd824bce01 18:56:27 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 18:56:27 INFO - mozversion INFO | platform_version: 45.0a1 18:56:27 INFO - 2015-11-21 18:56:27,518 DEBUG : using testdate: 1448160987 18:56:27 INFO - 2015-11-21 18:56:27,518 DEBUG : actual date: 1448160987 18:56:27 INFO - 2015-11-21 18:56:27,565 INFO : starting webserver on 'localhost:52374' 18:56:27 INFO - 2015-11-21 18:56:27,566 INFO : Starting test suite talos-linux64-ix-023 18:56:27 INFO - 2015-11-21 18:56:27,566 INFO : Starting test dromaeo_css 18:56:27 INFO - 2015-11-21 18:56:27,566 DEBUG : operating with platform_type : linux_ 18:56:27 INFO - 2015-11-21 18:56:27,567 INFO : Initialising browser for dromaeo_css test... 18:56:27 INFO - 2015-11-21 18:56:27,579 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeoRSAr/profile http://localhost:52374/getInfo.html 18:56:31 INFO - 2015-11-21 18:56:31,829 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:56:31 INFO - 2015-11-21 18:56:31,829 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:56:31 INFO - 2015-11-21 18:56:31,829 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:56:31 INFO - 2015-11-21 18:56:31,829 DEBUG : BROWSER_OUTPUT: __metrics 18:56:31 INFO - 2015-11-21 18:56:31,893 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:56:33 INFO - 2015-11-21 18:56:33,299 INFO : Browser initialized. 18:56:33 INFO - 2015-11-21 18:56:33,300 INFO : Running cycle 1/1 for dromaeo_css test... 18:56:33 INFO - 2015-11-21 18:56:33,300 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeoRSAr/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:56:45 INFO - 2015-11-21 18:56:45,087 DEBUG : BROWSER_OUTPUT: RSS: Main: 141819904 18:56:45 INFO - 2015-11-21 18:56:45,087 DEBUG : BROWSER_OUTPUT: 18:57:35 INFO - 2015-11-21 18:57:35,873 DEBUG : BROWSER_OUTPUT: 1448161055871 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:59:45 INFO - 2015-11-21 18:59:45,716 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52374/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52374/tests/dromaeo/cssquery-ext.html) 18:59:46 INFO - 2015-11-21 18:59:46,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 264241152 18:59:46 INFO - 2015-11-21 18:59:46,881 DEBUG : BROWSER_OUTPUT: 19:02:49 INFO - 2015-11-21 19:02:49,253 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52374/tests/dromaeo/cssquery-ext.html (next: http://localhost:52374/tests/dromaeo/cssquery-jquery.html) 19:02:49 INFO - 2015-11-21 19:02:49,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 226213888 19:02:49 INFO - 2015-11-21 19:02:49,819 DEBUG : BROWSER_OUTPUT: 19:05:51 INFO - 2015-11-21 19:05:51,701 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52374/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52374/tests/dromaeo/cssquery-mootools.html) 19:05:52 INFO - 2015-11-21 19:05:52,268 DEBUG : BROWSER_OUTPUT: RSS: Main: 229396480 19:05:52 INFO - 2015-11-21 19:05:52,268 DEBUG : BROWSER_OUTPUT: 19:08:54 INFO - 2015-11-21 19:08:54,102 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52374/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52374/tests/dromaeo/cssquery-prototype.html) 19:08:54 INFO - 2015-11-21 19:08:54,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 204439552 19:08:54 INFO - 2015-11-21 19:08:54,663 DEBUG : BROWSER_OUTPUT: 19:11:57 INFO - 2015-11-21 19:11:57,066 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52374/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52374/tests/dromaeo/cssquery-yui.html) 19:11:57 INFO - 2015-11-21 19:11:57,631 DEBUG : BROWSER_OUTPUT: RSS: Main: 209797120 19:11:57 INFO - 2015-11-21 19:11:57,631 DEBUG : BROWSER_OUTPUT: 19:15:00 INFO - 2015-11-21 19:15:00,388 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52374/tests/dromaeo/cssquery-yui.html (next: http://localhost:52374/tests/dromaeo/cssquery-dojo.html) 19:15:00 INFO - 2015-11-21 19:15:00,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 248713216 19:15:00 INFO - 2015-11-21 19:15:00,638 DEBUG : BROWSER_OUTPUT: 19:15:00 INFO - 2015-11-21 19:15:00,638 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:15:00 INFO - 2015-11-21 19:15:00,638 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:15:00 INFO - 2015-11-21 19:15:00,638 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:15:00 INFO - 2015-11-21 19:15:00,639 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:15:00 INFO - 2015-11-21 19:15:00,642 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3137.5764271823305;3281.950770738441;3315.8342082895833;3316.684914933082;3344.381289461449;5218.8695282617955;5363.383210930744;5439.646422982503;5509;5523.061079616465;5364.517193452589;5450.264214331064;5502.724863756806;5507.366652834925;5524.4199359067325;4948.307236986825;4968.1554135797005;4976.701397916118;5037.4710655381205;5076.974615126919;4808.2547205183255;5088.211327244283;5106.514881086291;5128.05131050755;5180.844574662766;4931.432885218192;4967.677100988424;5006.824761133379;5047.116754567973;5068;4933.580645645125;4980.501949805027;4989.376327959005;4999.325091112726;5048.091343558158;4762.261849413347;4981.327520784684;4994.550490455877;4995.900081998339;5064.164412871909;5119.360079990001;5196.29849970253;5205.453427390107;5209.791608335662;5245.186996015624;5917.970410147965;5924.674142922137;5981.7906373277165;5987.0420732683;5999.070144127667;5693.17448969897;5789.681567513785;5993.041113421875;6020;6023.307319658252;5375.5162035417;5438.755256013489;5452.100403433429;5462.399136095027;5507.669539827583;6004.099385092184;6016.819495415145;6033.276006879115;6085.2393450818645;6097.207363042776;5797.159411885337;5846.444587764156;5859.912101318484;5866.70666466675;5896.498797602166;5755.165501002331;5818.76724930998;5886.646801191857;5891.941080589225;5991.490723288569;5949.137375080676;5963.4931030862;5964.254468191476;5970.910436343458;5972.910406343908;5655.773769049274;5940.643561386244;5947.524198064145;5955.464008239279;5958.672273025025;4406.779661016936;4466.330050492387;4478.708883922534;4500.167469018242;4509.774511274423;4007.0583412897945;4025.6980726445636;4035.092104276573;4047.5952404759287;4055.4727885374714;5394.190871369326;5532.640378375393;5536.141898005815;5536.2249285100115;5543.61194716374;5793.507551858055;5835.503982161564;5867.73595188209;5879.2944846618675;5910.822675319747;5540.085885828874;5575.219469274305;5586.050371436784;5589.357223919302;5594.804181853616;4927.260910863328;5116.386033675908;5127.9230811537855;5128.487151284916;5182.0413223553005;5948.613340132878;5963.254593175853;5974.283086029617;6065.54508411862;6069.878602428015;5859.355470898113;5911.763529458945;5922.052471604523;5931.555133365101;5937.2578427696535;6081;6093.695315234309;6095.725692343944;6097.024476083805;6097.5731698780655;5588;5695.430456954437;5710.628809127394;5718.51392631631;5755.107958266475;5968.76124954997;5971.253593300838;5972.044472884318;5972.193753843176;5975.970120149545;5815.3603103657715;5815.563832712479;5820.0396934507025;5822.912656310244;5828.5919985602295;5642.294713160855;5688.3742788294085;5707.343655479673;5778.479936805539;5811.883762324815;5671.886562268649;5674.716264186856;5682.119271512922;5727.427257274239;5770.1344798278915;5786.537077033911;5792.652440853562;5793.188953546422;5804.65172089676;5819.738111784895;5380.650257733235;5505.697186654773;5508.091164957737;5605.5795815313195;5637.520810731134 19:15:00 INFO - 2015-11-21 19:15:00,642 DEBUG : BROWSER_OUTPUT: |1;ext.html;575.942405759424;577.8757567123071;580.7096451774113;582.7785441532217;587.0108866559847;30287.394252114944;38592.61407385925;39485;39498.01254968624;39509.20981580367;41741.16517669645;42116.789416052954;42145;42160.78919605398;42216.788916055375;7559.092908850946;7648.0822301323915;8630.913690863104;8811.074837142072;8814.294856411503;10359.378437293748;10637.308574942605;10646.78706425871;10647.680569582924;10651.680449586525;10219.48902554873;10316.123129533999;10320.225983051263;10326.277160598762;10329.173666106732;7813.804654883616;7944.801379965489;10251.641192558225;10352.275340726152;10549.84175237372;10122.240831937634;10262.897371026269;10265.281430299881;10272.28094033418;10280.845787313196;38642.22715545702;38732.612673873184;38934.61065389338;39012;39095.8045209775;3343.732501399882;3412.4540073588105;3514.0512061743184;3802.2395520895657;3846.8845934622004;28870.422591548053;29530.852345738134;29567.852160739058;29777.851110744523;29892;3758.962410375916;3871.7483363581277;3876.6898648108086;3887.9611203888167;3990.0572356525;270220;270419;270543;271045;271494;54581.727091364286;54809.16335856532;54820.72589637026;54830.72584637131;54883.45116548784;57883.71058144682;58068;58211;58237.41762582405;58305.70847145737;14503.274836258144;14633.268336583342;14674.853251467348;14675.48635797742;14676.55970320892;10529.05238528536;10544.314619549705;10563.366198028143;10570.735731606772;10570.841437378445;17723.379681711078;18226;18244.270229190948;18455.81544184568;18482.445526634223;6191.597546159485;7349.375303099189;7607.885881711779;7684;7795.103563090203;942.820864035831;961.624966263158;992.3648864726581;1034.5603118674533;1037.4138611684525;26367.34081647936;26491.867540662173;26578.6013209802;26703.599446008324;26731.465370692866;1061.7345663584103;1067.7010437077631;1120.2606279855256;1147.3345459633392;1147.3804145761362;13918.234497102554;13996.370163342674;14165.150090994573;14167.645808854655;14196.929015354857;311394;317305;317383;318095;318245;49633.50366496289;50461.24308135381;50461.24308135381;50476;50477.74761126244;1314.8882345000782;1328.103530117167;1333.5199328241824;1336.8061631063636;1340.4906135668384;26475.205743827715;26980;27046;27154;27693.30766730848;43021.70934871959;43271.56728432801;43330.35004474998;43354.349684754125;43413.782931085145;214539;392747;393575;400288;403073;30655.386892262475;30706.385872281982;30722.385552289277;30728.231794205323;31024.68975310218;42259;43046.78476607597;43071;43637.12725745404;43717.344239835795;35446;35710;36146.09634759047;36487;36995.44506832346;33673.15817104592;34502.65497344994;34934.82532587321;35208.767693131646;35593.82203088968;32118.83940580282;32836.50745238871;33094.33811323808;33182;33202.667973320924;28059.29851753641;30106.24734381658;30992.375565836614;31996;33401.49897751584;24477.877610612544;24827.62758558587;24984.625230621918;25024.874875626232;25314.24057278211 19:15:00 INFO - 2015-11-21 19:15:00,646 DEBUG : BROWSER_OUTPUT: |2;jquery.html;350.8053030568035;351.84342967379513;353.9185987222937;354.0387846995407;354.1429740029129;14410.92794536026;14463.710725785479;16964.4062457814;17080.658386832256;17533.736993945102;15392.692146157098;16284.185790710477;16531.338746450157;16775.74836377452;16780.83219167808;5151.253068305094;5320.680759154444;5324.041672498949;5326.147816349385;5327.307450031491;3891.124496988183;3977.1250324928615;5258.47415258473;5349.946500534984;5878.059510478324;5971.850703732398;6004.039353703409;6019.367966363513;6026.909596356037;6028.367021462749;5101.69389836611;5217.50433708797;5227.032998895179;5229.555487783524;5977.163197152402;4891.951080489185;5049.065922804293;5075.746212689351;5078.898422031576;5091.389033315989;12573.99408047354;12735.55425560101;12762.17045892014;17767.822321776745;20757.792422075738;2086.447091520748;2086.8539202255847;2093.905774240163;2148.5917675641736;2233.798958093779;9477.194438472738;9477.620895164186;9513.952430237805;9654.22766178704;9842;1659.0875018739646;1770.1857145712988;1838.2555065198483;1877.8685492015563;1890.9905450472659;60189.699051504904;64286.678566607334;64320.678396608186;65014.34985650177;65476;9125.680601178927;9218.446893186296;9272.072792720674;9536.2371010319;9872.457014864107;11677.416129193507;11741.236819606698;11753.4710938008;11780.941095294469;11826.52693892252;6853.246142924274;6853.417459515997;6953.513254072166;6971.511994160462;7156.212816590171;6641.767538136142;6658.134442522538;6688.598684078874;6703.396694297537;6709.832254193587;4266.5946735060115;4267.65858731307;4268.189044081614;4334.45819272591;4426.867193984185;1717.1328479117965;1745.5810605454853;1764;1778.386456672446;1792.6683563540787;868.4268382867277;875.7197696736984;907.1291560102376;907.650554536495;1020.3928662445833;16211.51365459038;16862.662746744998;17292.567685807957;17318;17322.82677173212;866.9956650216835;891.5408564589242;921.9308551858637;930.6370515498961;974.9179303573438;7555.73554925575;9754.75613109678;9814.411135331902;9836.114749672564;9851.211903047739;553673;555442;557213;557361;567089;78376.60811695905;79339.20660793433;80101.59949200333;80174;80451.19548804555;1078.0297732041226;1079.5034284229184;1090.1006669497697;1099.433791597328;1101.8815901859618;14933.477328293891;15062.171580562735;15121.546353609408;15149.621259468602;15461.922690386476;35017.299654007285;35590.46614300736;35676;36210.27579448449;37769.433458497595;43007;43065.569344306154;43106.78446607747;43674.34488482739;44506.55493445024;8819.470831750115;8915.331350148894;8975.371723979259;9014.23379012765;9046.819063618823;10731.624393146203;10822;10850.131989440668;17001;17090.03464601537;11432;11663.708407289547;13367.799483007568;14338.211398373189;14828.62928426798;13337.19976801395;13366.532171373956;13728.802643508105;13734.244616546186;13904.165750055028;11552.59565915189;12060.698482538006;13149.53976610814;15072.171030592985;15189.772153417487;9125.22435592982;9189.678361257324;9247.12152345526;9255.76860578491;9462.290328225274;10010.249231307535;10122.190224781853;12889.226646401246;13788.172709637454;14215.64460888486 19:15:00 INFO - 2015-11-21 19:15:00,647 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1223.7063104854838;1664.7919010123735;1710.5723569107722;1727.3867776939182;1740.4169603182934;6547.574407663505;7136.714531418744;7343.192248852622;7359.77920662381;7368.300011498905;7131.964340178291;7252.202257751643;7270.527415717987;7271.236520165386;7277.381422579074;1953.3261024946441;1991.7609886813602;2231.252530402317;2287.085165933627;2311.595470792613;2354.493783836475;2360.6695062691238;2365.2312998275543;2365.3377054424786;2366.8343215974887;2231.553689262154;2271.068861766676;2283.5090455552054;2287.9313620591324;2289.1301305503885;1978.9505262368411;2016.0726066009654;2218.3234113595427;2239.2162743039808;2256.684064231009;2244.1920908472935;2244.8204143668468;2282.2582660635194;2294.1740973249616;2294.7475777664445;7291.8906216406795;7318.81702957425;7328.596927169004;7330.743423980189;7347.595882226476;4423.181711383372;4480.641548676098;4507.774611269423;4516.164509565708;4519.683622146451;3106.4718997770206;3152.1016510294685;3219.645838957736;3226.903192904193;3230.16015835882;1051.6003918510917;1057.5769692123213;1096.9945150274198;1107.501624269074;1131.4342828585707;9804.852927206097;9923.454210018519;9925.801483970281;9933.701988940344;9949.751256218653;4172.937405938914;4219.409282700424;4247.851325203665;4270.914581708348;4293.334533147367;8222.054463736627;8333.250007499355;8360.874586881202;8362.24739773411;8367.205115514016;4574.153781550423;4599.33309670096;4605.03294308199;4607.216773148506;4614.538546145359;4216.2199993001395;4253.468316460442;4266.0827921996915;4267.018585725301;4270.145970805851;3402.489626555987;3462.5844898612327;3480.3561341151462;3494.3186078714916;3504.964950350464;1086.5165001574383;1095.4851219926622;1095.8794532601407;1099.9505022274018;1102.1458369763336;1024.0476356987924;1044.6813721814767;1045.5347370420243;1129.1136457880689;1230.944607492665;6931.861362772716;6937.514373993772;6954;6979.685914133876;6981.82545436358;1153.9192256542128;1194.8745381734966;1214.5202644955193;1233.1552886272932;1236.486857953957;5577.8047768327915;5608.9439105609235;5678.4605462480995;5685.658860468385;5689.089745640677;8799.560021998874;8922.821543569222;8943.463392196489;9033;9076.41003334781;8863.911360886437;8931.106889311146;8936.8659470108;8975.057618949917;8975.102489750972;6628.370304821035;6803.727850886008;6836.418904393083;6871.312868713088;6881.552699074544;6512.804615861532;6588.07766912623;6605.372489613479;6606.10817539626;6631.701573429304;7572.3942084632;7765.456418050908;7811.726589569338;7813.3749300057;7847.489913155627;7859.646315915912;8001.559914204542;8005.279524842559;8009.319207867164;8114.391420643594;6430.582012169194;6478.902816457663;6530.281669016499;6625.138731964814;6629.270780214269;7145.071140751669;7160.319769621878;7176.928230717835;7183.353498185188;7206;6652.068710380454;6678.465722742266;6684.4318232950745;6791.185057793096;6804.693788779417;5743.529435214543;6233.2208473940755;6282.434580887742;6318.273398559225;6752.864942701217;6636.800895973129;6733.225679046972;6734.494912881455;6749.797506074629;6783;6108.08378743192;6145.508359331332;6161.353057929032;6180.969095154495;6190.907136393048;6105.358937311696;6109.511239100772;6160.353162918008;6161.568690191643;6168.136460895568 19:15:00 INFO - 2015-11-21 19:15:00,649 DEBUG : BROWSER_OUTPUT: |4;prototype.html;327.9131030276976;336.1964903879727;338.66472192529386;347.4267458693154;351.21678656595793;5799.565032622549;5926.88146237075;5951.642901425912;5997.580169388139;6028.03551431771;5754.971225143879;5879.588428809985;5891.204687367204;5904.291485021793;5904.734286957087;4548.5224051474615;4603.217453032992;4604.539546045386;4621.5378462153685;4628.213203755353;4406.272964960777;4498.842540511083;4500.842470513533;4617.699849509771;4621.514740952202;4553.726776393427;4556.589906908378;4561.498235194126;4567.429071366079;4579;4583.839565615204;4586.472555656109;4588.678792484528;4597.310403439494;4608.078384323116;4049.514058312992;4058.391241313797;4059.2287465381482;4070.5318888327924;4071.2875246831686;5561.045017983514;5619.072852979253;5653.462921022497;5656.971715141439;5660.85847853807;5261.289725886994;5303.920441193385;5321.3348331458565;5333.679979201222;5357.303550538405;6234.2830574483605;6234.407731265523;6240.781572644981;6303.842403939892;6306.369363063657;4469.195544801934;4470.955290447087;4471.8658440246845;4471.888202794924;4477.059817438342;6413.134226879405;6551.639659818708;6560.245571759261;6611.4380277676455;6614.437772789319;4361.193179261783;4389.473263208435;4404.075144219686;4406.140802543473;4406.471223453206;4456.62118719906;4458.4426946631675;4459.44256967879;4460.487043989918;4461.152381047591;5125.205593133071;5212.296339994128;5216.556592689664;5220.216967454912;5220.3735551734035;6363.236411630634;6395.360463953567;6403.551751377452;6410.423061924356;6416.518761092937;1575.4013474879473;1576.6452548176799;1577.2350410051115;1578.763185522181;1579.636683562787;1060.7136073260176;1063.0857462582173;1063.4257500949554;1069.3209811769427;1090.8963648453384;6136.969315153396;6159.81520554384;6163.630182188993;6165;6170.382961703794;6300.21247344082;6407.231132264065;6509.414152726277;6584.8353791155605;6587.209534855752;6181.196444462191;6199.814005579839;6206.751729930843;6211.16149319836;6211.16149319845;3531.2407832316176;3568.1614820517157;3570.5001299818045;3570.767900086486;3571.8392672329805;6622.668866556653;6829.7268109276065;6832;6835.14560679915;6851.794446166623;6772.932270677329;6777.457803375718;6784.559003664746;6784.864302713918;6795.082663840417;6753.459723222229;6771.221309549464;6772.492063095287;6782.321767823179;6785.423239024738;6427.839304017437;6581.934180658132;6588.868222635616;6593.571417857824;6595.1096601958125;6493.350664933469;6497.18785151856;6498.805035848932;6503.869922601427;6504.9674751625935;6794.592324460548;6805.61803368817;6806.93193068063;6813.3527314905;6820.795376138723;4406.867793966187;4450.532694067077;4485.1926653201435;4494.595486406239;4498.190325741398;6534.509911756542;6546.476281897532;6559.0817285579105;6564.245111812203;6568.704408301543;6413.0701048348665;6419.550631455753;6424.261209960914;6431.807045788634;6434.613923164625;6240.032794916795;6326.240851097898;6339.397757213057;6348.143000694847;6394.4564712;6241.157443745036;6243.406876346739;6247.5001999840815;6260.906086408617;6268.749250029948;6412.294647588855;6414.5189110815945;6431.389018043278;6436.452901503425;6445.806625801233;6150.415710507495;6262.561620686508;6275.403836635513;6279.748810047729;6288.779892703734 19:15:00 INFO - 2015-11-21 19:15:00,650 DEBUG : BROWSER_OUTPUT: |5;yui.html;738.8300690841106;741.773759003504;753.7060546386907;798.9360851131909;802.79127426869;13004;13209.471621135142;13260.801087983677;13294.06941514092;13322.533711320106;12137.575184868532;12237.449314780833;12258.264504129758;12267.938660306709;12279.44742486588;669.9430548403392;671.664167916042;673.6732684647942;780.5082797837355;795.4908858330673;789.3290702902544;795.757294025322;801.3028665061405;802.7471346525825;804.4127786715701;789.2186735132207;831.3723139030054;845.6997765793147;846.3609974469298;846.7417437681505;693.4937495628194;699.4963626189161;822.5928165558028;830.016430529821;832.4464231286188;613.677819144948;614.5022531749297;615.9784407545759;616.3374372549528;619.683961179797;12129.696757581043;12191.634250972485;12228.938855305756;12274.202176858566;12313;11644.883551164465;11739.23694959825;11740.471678774476;12461.314627695474;13028.54400095992;10101;10156.644517441853;10455.790884182274;10602.522886470128;10647;3612.1330880588735;3628.455731640249;3650.0327413235514;3668.834902429397;3822.3502004659276;45850;46256.768716156206;46654.76672616649;46974;47119.52880471186;9810.607575697035;9906.306558540977;9925.15636170919;9973.60105595768;9974.650887218913;15868.761968570481;15874.52376428709;15892.125933073561;15935.840641593435;15953.840461595235;7242.23956484572;7292.963535182396;7408.518446300973;7469;7605.125410577854;3994.960050399517;4052.3111071117983;4065.5527891931865;4093.488313960755;4131.049858532554;3203.855826487767;3231.159898426426;3237.206884313311;3241.62721287055;3244.3186930744337;561.5760101123625;577.566824881339;584.290087543628;594.0940066398776;599.3227652752362;625.2965413909352;653.6013032050446;677.9525433219627;688.1707542411382;712.918014428337;8922.643094276285;8922.910770892338;9092.181703646704;9106.408083474686;9185.035571265054;624.6720471752367;634.463878023079;649.8342922554813;665.8468552233013;680.8604236131581;3813.637704418076;3834.3481608126685;4002.459667944848;4019.8995025124023;4119.829777115032;55868.72065639646;57465.71267143721;57471;57867;57953.42046579564;49689;50384.74807626012;50726.74636626793;51502;51618.22572661413;45017.54982450199;45585.08829823385;45866.312005319945;45909.7704511482;46195.538044619796;7916.168802275678;7944.602769861368;7957.173618310907;8025.8796118059445;8172.141925098017;33252.83373583117;33690;33744.49383259302;35692;36081.639183607826;45062.32406513971;45417;45624;46252.07495849997;46409.535904641874;11081.778364432505;11082.390468524309;11193.27243729155;11253.887461125283;11412.31526108436;11636.650900473;11675.941620291844;11712.765744685228;11885.405729713308;12388.318642474751;11142.930754290659;11336.319820810777;11342.432878355885;11359.886401136213;11749.76500470003;11086.279391839505;11154.442277885912;11240.156988225752;11502.137339699724;11883.346415947206;7689.807754806175;10750.73123171927;11116.555337786722;11133.498992545194;11158.665240042812;9806.166475849634;9896.50517474109;9994.450305233282;10026.042956024088;10129.797404052026;9560.28297877648;9623.514397383822;9631.807363852824;9884.209263258777;9953.552090155816 19:15:00 INFO - 2015-11-21 19:15:00,650 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:15:00 INFO - 2015-11-21 19:15:00,650 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:15:00 INFO - 2015-11-21 19:15:00,650 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,918 19:15:00 INFO - 2015-11-21 19:15:00,650 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:15:00 INFO - 2015-11-21 19:15:00,650 DEBUG : BROWSER_OUTPUT: __startTimestamp1448162100637__endTimestamp 19:15:00 INFO - 2015-11-21 19:15:00,650 DEBUG : BROWSER_OUTPUT: 19:15:00 INFO - 2015-11-21 19:15:00,650 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:15:00 INFO - 2015-11-21 19:15:00,651 DEBUG : BROWSER_OUTPUT: Number of tests: 6 19:15:00 INFO - 2015-11-21 19:15:00,651 DEBUG : BROWSER_OUTPUT: 19:15:00 INFO - 2015-11-21 19:15:00,651 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5457.91 Median:5655.77 stddev:616.86 (10.9%) stddev-sans-first:591.29 19:15:00 INFO - 2015-11-21 19:15:00,651 DEBUG : BROWSER_OUTPUT: Values: 3137.6 3282.0 3315.8 3316.7 3344.4 5218.9 5363.4 5439.6 5509.0 5523.1 5364.5 5450.3 5502.7 5507.4 5524.4 4948.3 4968.2 4976.7 5037.5 5077.0 4808.3 5088.2 5106.5 5128.1 5180.8 4931.4 4967.7 5006.8 5047.1 5068.0 4933.6 4980.5 4989.4 4999.3 5048.1 4762.3 4981.3 4994.6 4995.9 5064.2 5119.4 5196.3 5205.5 5209.8 5245.2 5918.0 5924.7 5981.8 5987.0 5999.1 5693.2 5789.7 5993.0 6020.0 6023.3 5375.5 5438.8 5452.1 5462.4 5507.7 6004.1 6016.8 6033.3 6085.2 6097.2 5797.2 5846.4 5859.9 5866.7 5896.5 5755.2 5818.8 5886.6 5891.9 5991.5 5949.1 5963.5 5964.3 5970.9 5972.9 5655.8 5940.6 5947.5 5955.5 5958.7 4406.8 4466.3 4478.7 4500.2 4509.8 4007.1 4025.7 4035.1 4047.6 4055.5 5394.2 5532.6 5536.1 5536.2 5543.6 5793.5 5835.5 5867.7 5879.3 5910.8 5540.1 5575.2 5586.1 5589.4 5594.8 4927.3 5116.4 5127.9 5128.5 5182.0 5948.6 5963.3 5974.3 6065.5 6069.9 5859.4 5911.8 5922.1 5931.6 5937.3 6081.0 6093.7 6095.7 6097.0 6097.6 5588.0 5695.4 5710.6 5718.5 5755.1 5968.8 5971.3 5972.0 5972.2 5976.0 5815.4 5815.6 5820.0 5822.9 5828.6 5642.3 5688.4 5707.3 5778.5 5811.9 5671.9 5674.7 5682.1 5727.4 5770.1 5786.5 5792.7 5793.2 5804.7 5819.7 5380.7 5505.7 5508.1 5605.6 5637.5 19:15:00 INFO - 2015-11-21 19:15:00,651 DEBUG : BROWSER_OUTPUT: 19:15:00 INFO - 2015-11-21 19:15:00,651 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47635.38 Median:32057.42 stddev:84325.64 (263.0%) stddev-sans-first:84488.17 19:15:00 INFO - 2015-11-21 19:15:00,652 DEBUG : BROWSER_OUTPUT: Values: 575.9 577.9 580.7 582.8 587.0 30287.4 38592.6 39485.0 39498.0 39509.2 41741.2 42116.8 42145.0 42160.8 42216.8 7559.1 7648.1 8630.9 8811.1 8814.3 10359.4 10637.3 10646.8 10647.7 10651.7 10219.5 10316.1 10320.2 10326.3 10329.2 7813.8 7944.8 10251.6 10352.3 10549.8 10122.2 10262.9 10265.3 10272.3 10280.8 38642.2 38732.6 38934.6 39012.0 39095.8 3343.7 3412.5 3514.1 3802.2 3846.9 28870.4 29530.9 29567.9 29777.9 29892.0 3759.0 3871.7 3876.7 3888.0 3990.1 270220.0 270419.0 270543.0 271045.0 271494.0 54581.7 54809.2 54820.7 54830.7 54883.5 57883.7 58068.0 58211.0 58237.4 58305.7 14503.3 14633.3 14674.9 14675.5 14676.6 10529.1 10544.3 10563.4 10570.7 10570.8 17723.4 18226.0 18244.3 18455.8 18482.4 6191.6 7349.4 7607.9 7684.0 7795.1 942.8 961.6 992.4 1034.6 1037.4 26367.3 26491.9 26578.6 26703.6 26731.5 1061.7 1067.7 1120.3 1147.3 1147.4 13918.2 13996.4 14165.2 14167.6 14196.9 311394.0 317305.0 317383.0 318095.0 318245.0 49633.5 50461.2 50461.2 50476.0 50477.7 1314.9 1328.1 1333.5 1336.8 1340.5 26475.2 26980.0 27046.0 27154.0 27693.3 43021.7 43271.6 43330.4 43354.3 43413.8 214539.0 392747.0 393575.0 400288.0 403073.0 30655.4 30706.4 30722.4 30728.2 31024.7 42259.0 43046.8 43071.0 43637.1 43717.3 35446.0 35710.0 36146.1 36487.0 36995.4 33673.2 34502.7 34934.8 35208.8 35593.8 32118.8 32836.5 33094.3 33182.0 33202.7 28059.3 30106.2 30992.4 31996.0 33401.5 24477.9 24827.6 24984.6 25024.9 25314.2 19:15:00 INFO - 2015-11-21 19:15:00,652 DEBUG : BROWSER_OUTPUT: 19:15:00 INFO - 2015-11-21 19:15:00,653 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28849.85 Median:23637.59 stddev:91271.80 (386.1%) stddev-sans-first:91502.75 19:15:00 INFO - 2015-11-21 19:15:00,654 DEBUG : BROWSER_OUTPUT: Values: 350.8 351.8 353.9 354.0 354.1 14410.9 14463.7 16964.4 17080.7 17533.7 15392.7 16284.2 16531.3 16775.7 16780.8 5151.3 5320.7 5324.0 5326.1 5327.3 3891.1 3977.1 5258.5 5349.9 5878.1 5971.9 6004.0 6019.4 6026.9 6028.4 5101.7 5217.5 5227.0 5229.6 5977.2 4892.0 5049.1 5075.7 5078.9 5091.4 12574.0 12735.6 12762.2 17767.8 20757.8 2086.4 2086.9 2093.9 2148.6 2233.8 9477.2 9477.6 9514.0 9654.2 9842.0 1659.1 1770.2 1838.3 1877.9 1891.0 60189.7 64286.7 64320.7 65014.3 65476.0 9125.7 9218.4 9272.1 9536.2 9872.5 11677.4 11741.2 11753.5 11780.9 11826.5 6853.2 6853.4 6953.5 6971.5 7156.2 6641.8 6658.1 6688.6 6703.4 6709.8 4266.6 4267.7 4268.2 4334.5 4426.9 1717.1 1745.6 1764.0 1778.4 1792.7 868.4 875.7 907.1 907.7 1020.4 16211.5 16862.7 17292.6 17318.0 17322.8 867.0 891.5 921.9 930.6 974.9 7555.7 9754.8 9814.4 9836.1 9851.2 553673.0 555442.0 557213.0 557361.0 567089.0 78376.6 79339.2 80101.6 80174.0 80451.2 1078.0 1079.5 1090.1 1099.4 1101.9 14933.5 15062.2 15121.5 15149.6 15461.9 35017.3 35590.5 35676.0 36210.3 37769.4 43007.0 43065.6 43106.8 43674.3 44506.6 8819.5 8915.3 8975.4 9014.2 9046.8 10731.6 10822.0 10850.1 17001.0 17090.0 11432.0 11663.7 13367.8 14338.2 14828.6 13337.2 13366.5 13728.8 13734.2 13904.2 11552.6 12060.7 13149.5 15072.2 15189.8 9125.2 9189.7 9247.1 9255.8 9462.3 10010.2 10122.2 12889.2 13788.2 14215.6 19:15:00 INFO - 2015-11-21 19:15:00,654 DEBUG : BROWSER_OUTPUT: 19:15:00 INFO - 2015-11-21 19:15:00,654 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5190.94 Median:6160.85 stddev:2595.99 (42.1%) stddev-sans-first:2586.13 19:15:00 INFO - 2015-11-21 19:15:00,656 DEBUG : BROWSER_OUTPUT: Values: 1223.7 1664.8 1710.6 1727.4 1740.4 6547.6 7136.7 7343.2 7359.8 7368.3 7132.0 7252.2 7270.5 7271.2 7277.4 1953.3 1991.8 2231.3 2287.1 2311.6 2354.5 2360.7 2365.2 2365.3 2366.8 2231.6 2271.1 2283.5 2287.9 2289.1 1979.0 2016.1 2218.3 2239.2 2256.7 2244.2 2244.8 2282.3 2294.2 2294.7 7291.9 7318.8 7328.6 7330.7 7347.6 4423.2 4480.6 4507.8 4516.2 4519.7 3106.5 3152.1 3219.6 3226.9 3230.2 1051.6 1057.6 1097.0 1107.5 1131.4 9804.9 9923.5 9925.8 9933.7 9949.8 4172.9 4219.4 4247.9 4270.9 4293.3 8222.1 8333.3 8360.9 8362.2 8367.2 4574.2 4599.3 4605.0 4607.2 4614.5 4216.2 4253.5 4266.1 4267.0 4270.1 3402.5 3462.6 3480.4 3494.3 3505.0 1086.5 1095.5 1095.9 1100.0 1102.1 1024.0 1044.7 1045.5 1129.1 1230.9 6931.9 6937.5 6954.0 6979.7 6981.8 1153.9 1194.9 1214.5 1233.2 1236.5 5577.8 5608.9 5678.5 5685.7 5689.1 8799.6 8922.8 8943.5 9033.0 9076.4 8863.9 8931.1 8936.9 8975.1 8975.1 6628.4 6803.7 6836.4 6871.3 6881.6 6512.8 6588.1 6605.4 6606.1 6631.7 7572.4 7765.5 7811.7 7813.4 7847.5 7859.6 8001.6 8005.3 8009.3 8114.4 6430.6 6478.9 6530.3 6625.1 6629.3 7145.1 7160.3 7176.9 7183.4 7206.0 6652.1 6678.5 6684.4 6791.2 6804.7 5743.5 6233.2 6282.4 6318.3 6752.9 6636.8 6733.2 6734.5 6749.8 6783.0 6108.1 6145.5 6161.4 6181.0 6190.9 6105.4 6109.5 6160.4 6161.6 6168.1 19:15:00 INFO - 2015-11-21 19:15:00,656 DEBUG : BROWSER_OUTPUT: 19:15:00 INFO - 2015-11-21 19:15:00,656 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5309.72 Median:6143.69 stddev:1606.22 (26.1%) stddev-sans-first:1566.60 19:15:00 INFO - 2015-11-21 19:15:00,657 DEBUG : BROWSER_OUTPUT: Values: 327.9 336.2 338.7 347.4 351.2 5799.6 5926.9 5951.6 5997.6 6028.0 5755.0 5879.6 5891.2 5904.3 5904.7 4548.5 4603.2 4604.5 4621.5 4628.2 4406.3 4498.8 4500.8 4617.7 4621.5 4553.7 4556.6 4561.5 4567.4 4579.0 4583.8 4586.5 4588.7 4597.3 4608.1 4049.5 4058.4 4059.2 4070.5 4071.3 5561.0 5619.1 5653.5 5657.0 5660.9 5261.3 5303.9 5321.3 5333.7 5357.3 6234.3 6234.4 6240.8 6303.8 6306.4 4469.2 4471.0 4471.9 4471.9 4477.1 6413.1 6551.6 6560.2 6611.4 6614.4 4361.2 4389.5 4404.1 4406.1 4406.5 4456.6 4458.4 4459.4 4460.5 4461.2 5125.2 5212.3 5216.6 5220.2 5220.4 6363.2 6395.4 6403.6 6410.4 6416.5 1575.4 1576.6 1577.2 1578.8 1579.6 1060.7 1063.1 1063.4 1069.3 1090.9 6137.0 6159.8 6163.6 6165.0 6170.4 6300.2 6407.2 6509.4 6584.8 6587.2 6181.2 6199.8 6206.8 6211.2 6211.2 3531.2 3568.2 3570.5 3570.8 3571.8 6622.7 6829.7 6832.0 6835.1 6851.8 6772.9 6777.5 6784.6 6784.9 6795.1 6753.5 6771.2 6772.5 6782.3 6785.4 6427.8 6581.9 6588.9 6593.6 6595.1 6493.4 6497.2 6498.8 6503.9 6505.0 6794.6 6805.6 6806.9 6813.4 6820.8 4406.9 4450.5 4485.2 4494.6 4498.2 6534.5 6546.5 6559.1 6564.2 6568.7 6413.1 6419.6 6424.3 6431.8 6434.6 6240.0 6326.2 6339.4 6348.1 6394.5 6241.2 6243.4 6247.5 6260.9 6268.7 6412.3 6414.5 6431.4 6436.5 6445.8 6150.4 6262.6 6275.4 6279.7 6288.8 19:15:00 INFO - 2015-11-21 19:15:00,658 DEBUG : BROWSER_OUTPUT: 19:15:00 INFO - 2015-11-21 19:15:00,658 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13565.44 Median:46254.42 stddev:15817.00 (34.2%) stddev-sans-first:15832.04 19:15:00 INFO - 2015-11-21 19:15:00,659 DEBUG : BROWSER_OUTPUT: Values: 738.8 741.8 753.7 798.9 802.8 13004.0 13209.5 13260.8 13294.1 13322.5 12137.6 12237.4 12258.3 12267.9 12279.4 669.9 671.7 673.7 780.5 795.5 789.3 795.8 801.3 802.7 804.4 789.2 831.4 845.7 846.4 846.7 693.5 699.5 822.6 830.0 832.4 613.7 614.5 616.0 616.3 619.7 12129.7 12191.6 12228.9 12274.2 12313.0 11644.9 11739.2 11740.5 12461.3 13028.5 10101.0 10156.6 10455.8 10602.5 10647.0 3612.1 3628.5 3650.0 3668.8 3822.4 45850.0 46256.8 46654.8 46974.0 47119.5 9810.6 9906.3 9925.2 9973.6 9974.7 15868.8 15874.5 15892.1 15935.8 15953.8 7242.2 7293.0 7408.5 7469.0 7605.1 3995.0 4052.3 4065.6 4093.5 4131.0 3203.9 3231.2 3237.2 3241.6 3244.3 561.6 577.6 584.3 594.1 599.3 625.3 653.6 678.0 688.2 712.9 8922.6 8922.9 9092.2 9106.4 9185.0 624.7 634.5 649.8 665.8 680.9 3813.6 3834.3 4002.5 4019.9 4119.8 55868.7 57465.7 57471.0 57867.0 57953.4 49689.0 50384.7 50726.7 51502.0 51618.2 45017.5 45585.1 45866.3 45909.8 46195.5 7916.2 7944.6 7957.2 8025.9 8172.1 33252.8 33690.0 33744.5 35692.0 36081.6 45062.3 45417.0 45624.0 46252.1 46409.5 11081.8 11082.4 11193.3 11253.9 11412.3 11636.7 11675.9 11712.8 11885.4 12388.3 11142.9 11336.3 11342.4 11359.9 11749.8 11086.3 11154.4 11240.2 11502.1 11883.3 7689.8 10750.7 11116.6 11133.5 11158.7 9806.2 9896.5 9994.5 10026.0 10129.8 9560.3 9623.5 9631.8 9884.2 9953.6 19:15:00 INFO - 2015-11-21 19:15:00,659 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:15:00 INFO - 2015-11-21 19:15:00,659 DEBUG : BROWSER_OUTPUT: 19:15:01 INFO - 2015-11-21 19:15:01,373 INFO : Browser exited with error code: 0 19:15:01 INFO - 2015-11-21 19:15:01,389 INFO : Completed test dromaeo_css (00:18:33) 19:15:01 INFO - 2015-11-21 19:15:01,389 INFO : Starting test kraken 19:15:01 INFO - 2015-11-21 19:15:01,389 DEBUG : operating with platform_type : linux_ 19:15:01 INFO - 2015-11-21 19:15:01,389 INFO : Initialising browser for kraken test... 19:15:01 INFO - 2015-11-21 19:15:01,395 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdGTHmS/profile http://localhost:52374/getInfo.html 19:15:05 INFO - 2015-11-21 19:15:05,291 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:15:05 INFO - 2015-11-21 19:15:05,291 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:15:05 INFO - 2015-11-21 19:15:05,291 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:15:05 INFO - 2015-11-21 19:15:05,291 DEBUG : BROWSER_OUTPUT: __metrics 19:15:05 INFO - 2015-11-21 19:15:05,454 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:15:06 INFO - 2015-11-21 19:15:06,714 INFO : Browser initialized. 19:15:06 INFO - 2015-11-21 19:15:06,714 INFO : Running cycle 1/1 for kraken test... 19:15:06 INFO - 2015-11-21 19:15:06,714 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdGTHmS/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:15:18 INFO - 2015-11-21 19:15:18,502 DEBUG : BROWSER_OUTPUT: RSS: Main: 142438400 19:15:18 INFO - 2015-11-21 19:15:18,502 DEBUG : BROWSER_OUTPUT: 19:15:20 INFO - 2015-11-21 19:15:20,981 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52374/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52374/tests/kraken/driver.html?testName=audio-beat-detection) 19:15:21 INFO - 2015-11-21 19:15:21,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 179556352 19:15:21 INFO - 2015-11-21 19:15:21,562 DEBUG : BROWSER_OUTPUT: 19:15:24 INFO - 2015-11-21 19:15:24,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52374/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52374/tests/kraken/driver.html?testName=audio-dft) 19:15:24 INFO - 2015-11-21 19:15:24,699 DEBUG : BROWSER_OUTPUT: RSS: Main: 167497728 19:15:24 INFO - 2015-11-21 19:15:24,700 DEBUG : BROWSER_OUTPUT: 19:15:27 INFO - 2015-11-21 19:15:27,578 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52374/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52374/tests/kraken/driver.html?testName=audio-fft) 19:15:28 INFO - 2015-11-21 19:15:28,139 DEBUG : BROWSER_OUTPUT: RSS: Main: 151855104 19:15:28 INFO - 2015-11-21 19:15:28,140 DEBUG : BROWSER_OUTPUT: 19:15:30 INFO - 2015-11-21 19:15:30,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52374/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52374/tests/kraken/driver.html?testName=audio-oscillator) 19:15:30 INFO - 2015-11-21 19:15:30,692 DEBUG : BROWSER_OUTPUT: RSS: Main: 153710592 19:15:30 INFO - 2015-11-21 19:15:30,693 DEBUG : BROWSER_OUTPUT: 19:15:32 INFO - 2015-11-21 19:15:32,804 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52374/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52374/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:15:33 INFO - 2015-11-21 19:15:33,365 DEBUG : BROWSER_OUTPUT: RSS: Main: 156389376 19:15:33 INFO - 2015-11-21 19:15:33,366 DEBUG : BROWSER_OUTPUT: 19:15:36 INFO - 2015-11-21 19:15:36,332 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52374/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52374/tests/kraken/driver.html?testName=imaging-darkroom) 19:15:36 INFO - 2015-11-21 19:15:36,900 DEBUG : BROWSER_OUTPUT: RSS: Main: 156078080 19:15:36 INFO - 2015-11-21 19:15:36,900 DEBUG : BROWSER_OUTPUT: 19:15:40 INFO - 2015-11-21 19:15:40,285 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52374/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52374/tests/kraken/driver.html?testName=imaging-desaturate) 19:15:40 INFO - 2015-11-21 19:15:40,859 DEBUG : BROWSER_OUTPUT: RSS: Main: 155635712 19:15:40 INFO - 2015-11-21 19:15:40,859 DEBUG : BROWSER_OUTPUT: 19:15:43 INFO - 2015-11-21 19:15:43,584 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52374/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52374/tests/kraken/driver.html?testName=json-parse-financial) 19:15:44 INFO - 2015-11-21 19:15:44,158 DEBUG : BROWSER_OUTPUT: RSS: Main: 156045312 19:15:44 INFO - 2015-11-21 19:15:44,158 DEBUG : BROWSER_OUTPUT: 19:15:45 INFO - 2015-11-21 19:15:45,726 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52374/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52374/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:15:46 INFO - 2015-11-21 19:15:46,292 DEBUG : BROWSER_OUTPUT: RSS: Main: 165486592 19:15:46 INFO - 2015-11-21 19:15:46,292 DEBUG : BROWSER_OUTPUT: 19:15:48 INFO - 2015-11-21 19:15:48,084 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52374/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52374/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:15:48 INFO - 2015-11-21 19:15:48,673 DEBUG : BROWSER_OUTPUT: RSS: Main: 165396480 19:15:48 INFO - 2015-11-21 19:15:48,673 DEBUG : BROWSER_OUTPUT: 19:15:50 INFO - 2015-11-21 19:15:50,745 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52374/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52374/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:15:51 INFO - 2015-11-21 19:15:51,314 DEBUG : BROWSER_OUTPUT: RSS: Main: 169713664 19:15:51 INFO - 2015-11-21 19:15:51,314 DEBUG : BROWSER_OUTPUT: 19:15:53 INFO - 2015-11-21 19:15:53,741 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52374/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:15:54 INFO - 2015-11-21 19:15:54,322 DEBUG : BROWSER_OUTPUT: RSS: Main: 175726592 19:15:54 INFO - 2015-11-21 19:15:54,322 DEBUG : BROWSER_OUTPUT: 19:15:56 INFO - 2015-11-21 19:15:56,821 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:15:57 INFO - 2015-11-21 19:15:57,390 DEBUG : BROWSER_OUTPUT: RSS: Main: 174579712 19:15:57 INFO - 2015-11-21 19:15:57,390 DEBUG : BROWSER_OUTPUT: 19:15:59 INFO - 2015-11-21 19:15:59,058 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52374/tests/kraken/driver.html?testName=ai-astar) 19:15:59 INFO - 2015-11-21 19:15:59,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 232501248 19:15:59 INFO - 2015-11-21 19:15:59,309 DEBUG : BROWSER_OUTPUT: 19:15:59 INFO - 2015-11-21 19:15:59,309 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:15:59 INFO - 2015-11-21 19:15:59,309 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:15:59 INFO - 2015-11-21 19:15:59,309 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:15:59 INFO - 2015-11-21 19:15:59,309 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:15:59 INFO - 2015-11-21 19:15:59,309 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;110;106;111;111;111;101;110;111;107 19:15:59 INFO - 2015-11-21 19:15:59,310 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;146;125;156;159;124;150;145;125;157;126 19:15:59 INFO - 2015-11-21 19:15:59,310 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;160;160;161;162;159;164;160;161 19:15:59 INFO - 2015-11-21 19:15:59,310 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;87;91;72;71;72;113;90;71 19:15:59 INFO - 2015-11-21 19:15:59,310 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;90;135;89;91;90;132;90;91;129 19:15:59 INFO - 2015-11-21 19:15:59,310 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;109;109;109;110;109;110;110 19:15:59 INFO - 2015-11-21 19:15:59,310 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;145;145;145;145;146;145;145;145 19:15:59 INFO - 2015-11-21 19:15:59,310 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;97;96;95;95;95;95;95;95;95 19:15:59 INFO - 2015-11-21 19:15:59,310 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;59;60;59;60;60;60;69;57;59 19:15:59 INFO - 2015-11-21 19:15:59,311 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;71;70;69;70;69;69;69;68;69 19:15:59 INFO - 2015-11-21 19:15:59,311 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;84;85;84;84;86;93;84;84;85 19:15:59 INFO - 2015-11-21 19:15:59,311 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;123;123;120;129;120;116;124;116;117 19:15:59 INFO - 2015-11-21 19:15:59,311 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;140;151;152;151;141;143;150;146;141 19:15:59 INFO - 2015-11-21 19:15:59,311 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;69;67;67;65;67;66;67;65;66 19:15:59 INFO - 2015-11-21 19:15:59,311 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:15:59 INFO - 2015-11-21 19:15:59,311 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:15:59 INFO - 2015-11-21 19:15:59,312 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,925 19:15:59 INFO - 2015-11-21 19:15:59,312 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:15:59 INFO - 2015-11-21 19:15:59,312 DEBUG : BROWSER_OUTPUT: __startTimestamp1448162159307__endTimestamp 19:15:59 INFO - 2015-11-21 19:15:59,312 DEBUG : BROWSER_OUTPUT: 19:15:59 INFO - 2015-11-21 19:15:59,315 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:15:59 INFO - 2015-11-21 19:15:59,316 DEBUG : BROWSER_OUTPUT: Number of tests: 14 19:15:59 INFO - 2015-11-21 19:15:59,316 DEBUG : BROWSER_OUTPUT: 19:15:59 INFO - 2015-11-21 19:15:59,316 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.80 Median:110.50 stddev:3.26 (2.9%) stddev-sans-first:3.43 19:15:59 INFO - 2015-11-21 19:15:59,316 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 106.0 111.0 111.0 111.0 101.0 110.0 111.0 107.0 19:15:59 INFO - 2015-11-21 19:15:59,316 DEBUG : BROWSER_OUTPUT: 19:15:59 INFO - 2015-11-21 19:15:59,316 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.30 Median:148.00 stddev:14.73 (10.0%) stddev-sans-first:15.52 19:15:59 INFO - 2015-11-21 19:15:59,316 DEBUG : BROWSER_OUTPUT: Values: 146.0 125.0 156.0 159.0 124.0 150.0 145.0 125.0 157.0 126.0 19:15:59 INFO - 2015-11-21 19:15:59,317 DEBUG : BROWSER_OUTPUT: 19:15:59 INFO - 2015-11-21 19:15:59,317 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.70 Median:160.50 stddev:1.42 (0.9%) stddev-sans-first:1.48 19:15:59 INFO - 2015-11-21 19:15:59,317 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 160.0 160.0 161.0 162.0 159.0 164.0 160.0 161.0 19:15:59 INFO - 2015-11-21 19:15:59,317 DEBUG : BROWSER_OUTPUT: 19:15:59 INFO - 2015-11-21 19:15:59,317 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.00 Median:72.00 stddev:14.08 (19.6%) stddev-sans-first:14.46 19:15:59 INFO - 2015-11-21 19:15:59,317 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 87.0 91.0 72.0 71.0 72.0 113.0 90.0 71.0 19:15:59 INFO - 2015-11-21 19:15:59,317 DEBUG : BROWSER_OUTPUT: 19:15:59 INFO - 2015-11-21 19:15:59,317 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.70 Median:90.00 stddev:20.28 (22.5%) stddev-sans-first:20.98 19:15:59 INFO - 2015-11-21 19:15:59,317 DEBUG : BROWSER_OUTPUT: Values: 90.0 90.0 135.0 89.0 91.0 90.0 132.0 90.0 91.0 129.0 19:15:59 INFO - 2015-11-21 19:15:59,317 DEBUG : BROWSER_OUTPUT: 19:15:59 INFO - 2015-11-21 19:15:59,317 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 19:15:59 INFO - 2015-11-21 19:15:59,318 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 109.0 109.0 109.0 110.0 109.0 110.0 110.0 19:15:59 INFO - 2015-11-21 19:15:59,318 DEBUG : BROWSER_OUTPUT: 19:15:59 INFO - 2015-11-21 19:15:59,318 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 19:15:59 INFO - 2015-11-21 19:15:59,318 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 19:15:59 INFO - 2015-11-21 19:15:59,318 DEBUG : BROWSER_OUTPUT: 19:15:59 INFO - 2015-11-21 19:15:59,318 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 19:15:59 INFO - 2015-11-21 19:15:59,318 DEBUG : BROWSER_OUTPUT: Values: 95.0 97.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 19:15:59 INFO - 2015-11-21 19:15:59,318 DEBUG : BROWSER_OUTPUT: 19:15:59 INFO - 2015-11-21 19:15:59,318 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.30 Median:60.00 stddev:3.20 (5.3%) stddev-sans-first:3.39 19:15:59 INFO - 2015-11-21 19:15:59,318 DEBUG : BROWSER_OUTPUT: Values: 60.0 59.0 60.0 59.0 60.0 60.0 60.0 69.0 57.0 59.0 19:15:59 INFO - 2015-11-21 19:15:59,318 DEBUG : BROWSER_OUTPUT: 19:15:59 INFO - 2015-11-21 19:15:59,318 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.50 stddev:0.84 (1.2%) stddev-sans-first:0.87 19:15:59 INFO - 2015-11-21 19:15:59,318 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 70.0 69.0 70.0 69.0 69.0 69.0 68.0 69.0 19:15:59 INFO - 2015-11-21 19:15:59,318 DEBUG : BROWSER_OUTPUT: 19:15:59 INFO - 2015-11-21 19:15:59,319 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:84.50 stddev:2.86 (3.4%) stddev-sans-first:2.92 19:15:59 INFO - 2015-11-21 19:15:59,319 DEBUG : BROWSER_OUTPUT: Values: 83.0 84.0 85.0 84.0 84.0 86.0 93.0 84.0 84.0 85.0 19:15:59 INFO - 2015-11-21 19:15:59,319 DEBUG : BROWSER_OUTPUT: 19:15:59 INFO - 2015-11-21 19:15:59,319 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.00 Median:122.50 stddev:4.08 (3.3%) stddev-sans-first:4.31 19:15:59 INFO - 2015-11-21 19:15:59,319 DEBUG : BROWSER_OUTPUT: Values: 122.0 123.0 123.0 120.0 129.0 120.0 116.0 124.0 116.0 117.0 19:15:59 INFO - 2015-11-21 19:15:59,319 DEBUG : BROWSER_OUTPUT: 19:15:59 INFO - 2015-11-21 19:15:59,319 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.30 Median:148.00 stddev:5.33 (3.6%) stddev-sans-first:4.96 19:15:59 INFO - 2015-11-21 19:15:59,319 DEBUG : BROWSER_OUTPUT: Values: 138.0 140.0 151.0 152.0 151.0 141.0 143.0 150.0 146.0 141.0 19:15:59 INFO - 2015-11-21 19:15:59,319 DEBUG : BROWSER_OUTPUT: 19:15:59 INFO - 2015-11-21 19:15:59,319 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:1.26 (1.9%) stddev-sans-first:1.24 19:15:59 INFO - 2015-11-21 19:15:59,319 DEBUG : BROWSER_OUTPUT: Values: 65.0 69.0 67.0 67.0 65.0 67.0 66.0 67.0 65.0 66.0 19:15:59 INFO - 2015-11-21 19:15:59,319 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:15:59 INFO - 2015-11-21 19:15:59,319 DEBUG : BROWSER_OUTPUT: 19:16:00 INFO - 2015-11-21 19:16:00,165 INFO : Browser exited with error code: 0 19:16:00 INFO - 2015-11-21 19:16:00,220 INFO : Completed test kraken (00:00:58) 19:16:00 INFO - 2015-11-21 19:16:00,221 INFO : Starting test v8_7 19:16:00 INFO - 2015-11-21 19:16:00,221 DEBUG : operating with platform_type : linux_ 19:16:00 INFO - 2015-11-21 19:16:00,221 INFO : Initialising browser for v8_7 test... 19:16:00 INFO - 2015-11-21 19:16:00,227 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQxJhRQ/profile http://localhost:52374/getInfo.html 19:16:04 INFO - 2015-11-21 19:16:04,064 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:16:04 INFO - 2015-11-21 19:16:04,064 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:16:04 INFO - 2015-11-21 19:16:04,064 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:16:04 INFO - 2015-11-21 19:16:04,065 DEBUG : BROWSER_OUTPUT: __metrics 19:16:04 INFO - 2015-11-21 19:16:04,213 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:16:05 INFO - 2015-11-21 19:16:05,495 INFO : Browser initialized. 19:16:05 INFO - 2015-11-21 19:16:05,495 INFO : Running cycle 1/1 for v8_7 test... 19:16:05 INFO - 2015-11-21 19:16:05,496 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQxJhRQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:16:17 INFO - 2015-11-21 19:16:17,209 DEBUG : BROWSER_OUTPUT: RSS: Main: 141299712 19:16:17 INFO - 2015-11-21 19:16:17,209 DEBUG : BROWSER_OUTPUT: 19:16:38 INFO - 2015-11-21 19:16:38,667 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52374/tests/v8_7/run.html (next: http://localhost:52374/tests/v8_7/run.html) 19:16:38 INFO - 2015-11-21 19:16:38,917 DEBUG : BROWSER_OUTPUT: RSS: Main: 621760512 19:16:38 INFO - 2015-11-21 19:16:38,917 DEBUG : BROWSER_OUTPUT: 19:16:38 INFO - 2015-11-21 19:16:38,917 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:16:38 INFO - 2015-11-21 19:16:38,917 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:16:38 INFO - 2015-11-21 19:16:38,917 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:16:38 INFO - 2015-11-21 19:16:38,917 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:16:38 INFO - 2015-11-21 19:16:38,918 DEBUG : BROWSER_OUTPUT: |0;Richards;162.83992835043153 19:16:38 INFO - 2015-11-21 19:16:38,918 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.1370607649 19:16:38 INFO - 2015-11-21 19:16:38,918 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.57598178713715 19:16:38 INFO - 2015-11-21 19:16:38,918 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 19:16:38 INFO - 2015-11-21 19:16:38,918 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1107.4197120708748 19:16:38 INFO - 2015-11-21 19:16:38,918 DEBUG : BROWSER_OUTPUT: |5;Earley;782.4726134585289 19:16:38 INFO - 2015-11-21 19:16:38,918 DEBUG : BROWSER_OUTPUT: |6;Boyer;11916.666666666666 19:16:38 INFO - 2015-11-21 19:16:38,918 DEBUG : BROWSER_OUTPUT: |7;RegExp;25666.666666666668 19:16:38 INFO - 2015-11-21 19:16:38,919 DEBUG : BROWSER_OUTPUT: |8;Splay;681.4332247557003 19:16:38 INFO - 2015-11-21 19:16:38,919 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 19:16:38 INFO - 2015-11-21 19:16:38,919 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:16:38 INFO - 2015-11-21 19:16:38,919 DEBUG : BROWSER_OUTPUT: __startTimestamp1448162198914__endTimestamp 19:16:38 INFO - 2015-11-21 19:16:38,919 DEBUG : BROWSER_OUTPUT: 19:16:38 INFO - 2015-11-21 19:16:38,919 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:16:38 INFO - 2015-11-21 19:16:38,920 DEBUG : BROWSER_OUTPUT: Number of tests: 10 19:16:38 INFO - 2015-11-21 19:16:38,920 DEBUG : BROWSER_OUTPUT: 19:16:38 INFO - 2015-11-21 19:16:38,920 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.84 Median:162.84 stddev:0.00 (0.0%) 19:16:38 INFO - 2015-11-21 19:16:38,920 DEBUG : BROWSER_OUTPUT: Values: 162.8 19:16:38 INFO - 2015-11-21 19:16:38,920 DEBUG : BROWSER_OUTPUT: 19:16:38 INFO - 2015-11-21 19:16:38,920 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.14 Median:194.14 stddev:0.00 (0.0%) 19:16:38 INFO - 2015-11-21 19:16:38,920 DEBUG : BROWSER_OUTPUT: Values: 194.1 19:16:38 INFO - 2015-11-21 19:16:38,921 DEBUG : BROWSER_OUTPUT: 19:16:38 INFO - 2015-11-21 19:16:38,921 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.58 Median:284.58 stddev:0.00 (0.0%) 19:16:38 INFO - 2015-11-21 19:16:38,921 DEBUG : BROWSER_OUTPUT: Values: 284.6 19:16:38 INFO - 2015-11-21 19:16:38,921 DEBUG : BROWSER_OUTPUT: 19:16:38 INFO - 2015-11-21 19:16:38,921 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 19:16:38 INFO - 2015-11-21 19:16:38,921 DEBUG : BROWSER_OUTPUT: Values: 5040.2 19:16:38 INFO - 2015-11-21 19:16:38,921 DEBUG : BROWSER_OUTPUT: 19:16:38 INFO - 2015-11-21 19:16:38,921 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1107.42 Median:1107.42 stddev:0.00 (0.0%) 19:16:38 INFO - 2015-11-21 19:16:38,922 DEBUG : BROWSER_OUTPUT: Values: 1107.4 19:16:38 INFO - 2015-11-21 19:16:38,922 DEBUG : BROWSER_OUTPUT: 19:16:38 INFO - 2015-11-21 19:16:38,922 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:782.47 Median:782.47 stddev:0.00 (0.0%) 19:16:38 INFO - 2015-11-21 19:16:38,922 DEBUG : BROWSER_OUTPUT: Values: 782.5 19:16:38 INFO - 2015-11-21 19:16:38,922 DEBUG : BROWSER_OUTPUT: 19:16:38 INFO - 2015-11-21 19:16:38,922 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11916.67 Median:11916.67 stddev:0.00 (0.0%) 19:16:38 INFO - 2015-11-21 19:16:38,922 DEBUG : BROWSER_OUTPUT: Values: 11916.7 19:16:38 INFO - 2015-11-21 19:16:38,923 DEBUG : BROWSER_OUTPUT: 19:16:38 INFO - 2015-11-21 19:16:38,923 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25666.67 Median:25666.67 stddev:0.00 (0.0%) 19:16:38 INFO - 2015-11-21 19:16:38,923 DEBUG : BROWSER_OUTPUT: Values: 25666.7 19:16:38 INFO - 2015-11-21 19:16:38,923 DEBUG : BROWSER_OUTPUT: 19:16:38 INFO - 2015-11-21 19:16:38,923 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:681.43 Median:681.43 stddev:0.00 (0.0%) 19:16:38 INFO - 2015-11-21 19:16:38,923 DEBUG : BROWSER_OUTPUT: Values: 681.4 19:16:38 INFO - 2015-11-21 19:16:38,923 DEBUG : BROWSER_OUTPUT: 19:16:38 INFO - 2015-11-21 19:16:38,923 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 19:16:38 INFO - 2015-11-21 19:16:38,924 DEBUG : BROWSER_OUTPUT: Values: 4840.6 19:16:38 INFO - 2015-11-21 19:16:38,924 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:16:38 INFO - 2015-11-21 19:16:38,924 DEBUG : BROWSER_OUTPUT: 19:16:39 INFO - 2015-11-21 19:16:39,781 INFO : Browser exited with error code: 0 19:16:39 INFO - 2015-11-21 19:16:39,795 INFO : Completed test v8_7 (00:00:39) 19:16:39 INFO - 2015-11-21 19:16:39,872 INFO : Completed test suite (00:20:12) 19:16:39 INFO - 2015-11-21 19:16:39,872 DEBUG : Working with test: dromaeo_css 19:16:39 INFO - 2015-11-21 19:16:39,872 DEBUG : Generating results file: dromaeo_css 19:16:39 INFO - 2015-11-21 19:16:39,873 DEBUG : Working with test: kraken 19:16:39 INFO - 2015-11-21 19:16:39,873 DEBUG : Generating results file: kraken 19:16:39 INFO - 2015-11-21 19:16:39,873 INFO : javascript benchmark 19:16:39 INFO - 2015-11-21 19:16:39,874 DEBUG : Working with test: v8_7 19:16:39 INFO - 2015-11-21 19:16:39,874 DEBUG : Generating results file: v8_7 19:16:39 INFO - 2015-11-21 19:16:39,874 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:16:40 INFO - 2015-11-21 19:16:40,018 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 19:16:40 INFO - 2015-11-21 19:16:40,018 DEBUG : process_Request line: dromaeo_css 6906.90 graph.html#tests=[[72,201,35]] 19:16:40 INFO - 2015-11-21 19:16:40,019 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:16:40 INFO - 2015-11-21 19:16:40,046 DEBUG : process_Request line: kraken 1492.00 graph.html#tests=[[232,201,35]] 19:16:40 INFO - 2015-11-21 19:16:40,046 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:16:40 INFO - 2015-11-21 19:16:40,148 DEBUG : process_Request line: v8_7 20874.90 graph.html#tests=[[230,201,35]] 19:16:40 INFO - 2015-11-21 19:16:40,149 INFO : javascript benchmark 19:16:40 INFO - 2015-11-21 19:16:40,152 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3137.5764271823305, 3281.950770738441, 3315.8342082895833, 3316.684914933082, 3344.381289461449, 5218.8695282617955, 5363.383210930744, 5439.646422982503, 5509.0, 5523.061079616465, 5364.517193452589, 5450.264214331064, 5502.724863756806, 5507.366652834925, 5524.4199359067325, 4948.307236986825, 4968.1554135797005, 4976.701397916118, 5037.4710655381205, 5076.974615126919, 4808.2547205183255, 5088.211327244283, 5106.514881086291, 5128.05131050755, 5180.844574662766, 4931.432885218192, 4967.677100988424, 5006.824761133379, 5047.116754567973, 5068.0, 4933.580645645125, 4980.501949805027, 4989.376327959005, 4999.325091112726, 5048.091343558158, 4762.261849413347, 4981.327520784684, 4994.550490455877, 4995.900081998339, 5064.164412871909, 5119.360079990001, 5196.29849970253, 5205.453427390107, 5209.791608335662, 5245.186996015624, 5917.970410147965, 5924.674142922137, 5981.7906373277165, 5987.0420732683, 5999.070144127667, 5693.17448969897, 5789.681567513785, 5993.041113421875, 6020.0, 6023.307319658252, 5375.5162035417, 5438.755256013489, 5452.100403433429, 5462.399136095027, 5507.669539827583, 6004.099385092184, 6016.819495415145, 6033.276006879115, 6085.2393450818645, 6097.207363042776, 5797.159411885337, 5846.444587764156, 5859.912101318484, 5866.70666466675, 5896.498797602166, 5755.165501002331, 5818.76724930998, 5886.646801191857, 5891.941080589225, 5991.490723288569, 5949.137375080676, 5963.4931030862, 5964.254468191476, 5970.910436343458, 5972.910406343908, 5655.773769049274, 5940.643561386244, 5947.524198064145, 5955.464008239279, 5958.672273025025, 4406.779661016936, 4466.330050492387, 4478.708883922534, 4500.167469018242, 4509.774511274423, 4007.0583412897945, 4025.6980726445636, 4035.092104276573, 4047.5952404759287, 4055.4727885374714, 5394.190871369326, 5532.640378375393, 5536.141898005815, 5536.2249285100115, 5543.61194716374, 5793.507551858055, 5835.503982161564, 5867.73595188209, 5879.2944846618675, 5910.822675319747, 5540.085885828874, 5575.219469274305, 5586.050371436784, 5589.357223919302, 5594.804181853616, 4927.260910863328, 5116.386033675908, 5127.9230811537855, 5128.487151284916, 5182.0413223553005, 5948.613340132878, 5963.254593175853, 5974.283086029617, 6065.54508411862, 6069.878602428015, 5859.355470898113, 5911.763529458945, 5922.052471604523, 5931.555133365101, 5937.2578427696535, 6081.0, 6093.695315234309, 6095.725692343944, 6097.024476083805, 6097.5731698780655, 5588.0, 5695.430456954437, 5710.628809127394, 5718.51392631631, 5755.107958266475, 5968.76124954997, 5971.253593300838, 5972.044472884318, 5972.193753843176, 5975.970120149545, 5815.3603103657715, 5815.563832712479, 5820.0396934507025, 5822.912656310244, 5828.5919985602295, 5642.294713160855, 5688.3742788294085, 5707.343655479673, 5778.479936805539, 5811.883762324815, 5671.886562268649, 5674.716264186856, 5682.119271512922, 5727.427257274239, 5770.1344798278915, 5786.537077033911, 5792.652440853562, 5793.188953546422, 5804.65172089676, 5819.738111784895, 5380.650257733235, 5505.697186654773, 5508.091164957737, 5605.5795815313195, 5637.520810731134], "unit": "ms", "name": "dojo.html", "value": 5417.459475953543}, {"lowerIsBetter": false, "replicates": [575.942405759424, 577.8757567123071, 580.7096451774113, 582.7785441532217, 587.0108866559847, 30287.394252114944, 38592.61407385925, 39485.0, 39498.01254968624, 39509.20981580367, 41741.16517669645, 42116.789416052954, 42145.0, 42160.78919605398, 42216.788916055375, 7559.092908850946, 7648.0822301323915, 8630.913690863104, 8811.074837142072, 8814.294856411503, 10359.378437293748, 10637.308574942605, 10646.78706425871, 10647.680569582924, 10651.680449586525, 10219.48902554873, 10316.123129533999, 10320.225983051263, 10326.277160598762, 10329.173666106732, 7813.804654883616, 7944.801379965489, 10251.641192558225, 10352.275340726152, 10549.84175237372, 10122.240831937634, 10262.897371026269, 10265.281430299881, 10272.28094033418, 10280.845787313196, 38642.22715545702, 38732.612673873184, 38934.61065389338, 39012.0, 39095.8045209775, 3343.732501399882, 3412.4540073588105, 3514.0512061743184, 3802.2395520895657, 3846.8845934622004, 28870.422591548053, 29530.852345738134, 29567.852160739058, 29777.851110744523, 29892.0, 3758.962410375916, 3871.7483363581277, 3876.6898648108086, 3887.9611203888167, 3990.0572356525, 270220.0, 270419.0, 270543.0, 271045.0, 271494.0, 54581.727091364286, 54809.16335856532, 54820.72589637026, 54830.72584637131, 54883.45116548784, 57883.71058144682, 58068.0, 58211.0, 58237.41762582405, 58305.70847145737, 14503.274836258144, 14633.268336583342, 14674.853251467348, 14675.48635797742, 14676.55970320892, 10529.05238528536, 10544.314619549705, 10563.366198028143, 10570.735731606772, 10570.841437378445, 17723.379681711078, 18226.0, 18244.270229190948, 18455.81544184568, 18482.445526634223, 6191.597546159485, 7349.375303099189, 7607.885881711779, 7684.0, 7795.103563090203, 942.820864035831, 961.624966263158, 992.3648864726581, 1034.5603118674533, 1037.4138611684525, 26367.34081647936, 26491.867540662173, 26578.6013209802, 26703.599446008324, 26731.465370692866, 1061.7345663584103, 1067.7010437077631, 1120.2606279855256, 1147.3345459633392, 1147.3804145761362, 13918.234497102554, 13996.370163342674, 14165.150090994573, 14167.645808854655, 14196.929015354857, 311394.0, 317305.0, 317383.0, 318095.0, 318245.0, 49633.50366496289, 50461.24308135381, 50461.24308135381, 50476.0, 50477.74761126244, 1314.8882345000782, 1328.103530117167, 1333.5199328241824, 1336.8061631063636, 1340.4906135668384, 26475.205743827715, 26980.0, 27046.0, 27154.0, 27693.30766730848, 43021.70934871959, 43271.56728432801, 43330.35004474998, 43354.349684754125, 43413.782931085145, 214539.0, 392747.0, 393575.0, 400288.0, 403073.0, 30655.386892262475, 30706.385872281982, 30722.385552289277, 30728.231794205323, 31024.68975310218, 42259.0, 43046.78476607597, 43071.0, 43637.12725745404, 43717.344239835795, 35446.0, 35710.0, 36146.09634759047, 36487.0, 36995.44506832346, 33673.15817104592, 34502.65497344994, 34934.82532587321, 35208.767693131646, 35593.82203088968, 32118.83940580282, 32836.50745238871, 33094.33811323808, 33182.0, 33202.667973320924, 28059.29851753641, 30106.24734381658, 30992.375565836614, 31996.0, 33401.49897751584, 24477.877610612544, 24827.62758558587, 24984.625230621918, 25024.874875626232, 25314.24057278211], "unit": "ms", "name": "ext.html", "value": 18419.22705255714}, {"lowerIsBetter": false, "replicates": [350.8053030568035, 351.84342967379513, 353.9185987222937, 354.0387846995407, 354.1429740029129, 14410.92794536026, 14463.710725785479, 16964.4062457814, 17080.658386832256, 17533.736993945102, 15392.692146157098, 16284.185790710477, 16531.338746450157, 16775.74836377452, 16780.83219167808, 5151.253068305094, 5320.680759154444, 5324.041672498949, 5326.147816349385, 5327.307450031491, 3891.124496988183, 3977.1250324928615, 5258.47415258473, 5349.946500534984, 5878.059510478324, 5971.850703732398, 6004.039353703409, 6019.367966363513, 6026.909596356037, 6028.367021462749, 5101.69389836611, 5217.50433708797, 5227.032998895179, 5229.555487783524, 5977.163197152402, 4891.951080489185, 5049.065922804293, 5075.746212689351, 5078.898422031576, 5091.389033315989, 12573.99408047354, 12735.55425560101, 12762.17045892014, 17767.822321776745, 20757.792422075738, 2086.447091520748, 2086.8539202255847, 2093.905774240163, 2148.5917675641736, 2233.798958093779, 9477.194438472738, 9477.620895164186, 9513.952430237805, 9654.22766178704, 9842.0, 1659.0875018739646, 1770.1857145712988, 1838.2555065198483, 1877.8685492015563, 1890.9905450472659, 60189.699051504904, 64286.678566607334, 64320.678396608186, 65014.34985650177, 65476.0, 9125.680601178927, 9218.446893186296, 9272.072792720674, 9536.2371010319, 9872.457014864107, 11677.416129193507, 11741.236819606698, 11753.4710938008, 11780.941095294469, 11826.52693892252, 6853.246142924274, 6853.417459515997, 6953.513254072166, 6971.511994160462, 7156.212816590171, 6641.767538136142, 6658.134442522538, 6688.598684078874, 6703.396694297537, 6709.832254193587, 4266.5946735060115, 4267.65858731307, 4268.189044081614, 4334.45819272591, 4426.867193984185, 1717.1328479117965, 1745.5810605454853, 1764.0, 1778.386456672446, 1792.6683563540787, 868.4268382867277, 875.7197696736984, 907.1291560102376, 907.650554536495, 1020.3928662445833, 16211.51365459038, 16862.662746744998, 17292.567685807957, 17318.0, 17322.82677173212, 866.9956650216835, 891.5408564589242, 921.9308551858637, 930.6370515498961, 974.9179303573438, 7555.73554925575, 9754.75613109678, 9814.411135331902, 9836.114749672564, 9851.211903047739, 553673.0, 555442.0, 557213.0, 557361.0, 567089.0, 78376.60811695905, 79339.20660793433, 80101.59949200333, 80174.0, 80451.19548804555, 1078.0297732041226, 1079.5034284229184, 1090.1006669497697, 1099.433791597328, 1101.8815901859618, 14933.477328293891, 15062.171580562735, 15121.546353609408, 15149.621259468602, 15461.922690386476, 35017.299654007285, 35590.46614300736, 35676.0, 36210.27579448449, 37769.433458497595, 43007.0, 43065.569344306154, 43106.78446607747, 43674.34488482739, 44506.55493445024, 8819.470831750115, 8915.331350148894, 8975.371723979259, 9014.23379012765, 9046.819063618823, 10731.624393146203, 10822.0, 10850.131989440668, 17001.0, 17090.03464601537, 11432.0, 11663.708407289547, 13367.799483007568, 14338.211398373189, 14828.62928426798, 13337.19976801395, 13366.532171373956, 13728.802643508105, 13734.244616546186, 13904.165750055028, 11552.59565915189, 12060.698482538006, 13149.53976610814, 15072.171030592985, 15189.772153417487, 9125.22435592982, 9189.678361257324, 9247.12152345526, 9255.76860578491, 9462.290328225274, 10010.249231307535, 10122.190224781853, 12889.226646401246, 13788.172709637454, 14215.64460888486], "unit": "ms", "name": "jquery.html", "value": 8487.048466658116}, {"lowerIsBetter": false, "replicates": [1223.7063104854838, 1664.7919010123735, 1710.5723569107722, 1727.3867776939182, 1740.4169603182934, 6547.574407663505, 7136.714531418744, 7343.192248852622, 7359.77920662381, 7368.300011498905, 7131.964340178291, 7252.202257751643, 7270.527415717987, 7271.236520165386, 7277.381422579074, 1953.3261024946441, 1991.7609886813602, 2231.252530402317, 2287.085165933627, 2311.595470792613, 2354.493783836475, 2360.6695062691238, 2365.2312998275543, 2365.3377054424786, 2366.8343215974887, 2231.553689262154, 2271.068861766676, 2283.5090455552054, 2287.9313620591324, 2289.1301305503885, 1978.9505262368411, 2016.0726066009654, 2218.3234113595427, 2239.2162743039808, 2256.684064231009, 2244.1920908472935, 2244.8204143668468, 2282.2582660635194, 2294.1740973249616, 2294.7475777664445, 7291.8906216406795, 7318.81702957425, 7328.596927169004, 7330.743423980189, 7347.595882226476, 4423.181711383372, 4480.641548676098, 4507.774611269423, 4516.164509565708, 4519.683622146451, 3106.4718997770206, 3152.1016510294685, 3219.645838957736, 3226.903192904193, 3230.16015835882, 1051.6003918510917, 1057.5769692123213, 1096.9945150274198, 1107.501624269074, 1131.4342828585707, 9804.852927206097, 9923.454210018519, 9925.801483970281, 9933.701988940344, 9949.751256218653, 4172.937405938914, 4219.409282700424, 4247.851325203665, 4270.914581708348, 4293.334533147367, 8222.054463736627, 8333.250007499355, 8360.874586881202, 8362.24739773411, 8367.205115514016, 4574.153781550423, 4599.33309670096, 4605.03294308199, 4607.216773148506, 4614.538546145359, 4216.2199993001395, 4253.468316460442, 4266.0827921996915, 4267.018585725301, 4270.145970805851, 3402.489626555987, 3462.5844898612327, 3480.3561341151462, 3494.3186078714916, 3504.964950350464, 1086.5165001574383, 1095.4851219926622, 1095.8794532601407, 1099.9505022274018, 1102.1458369763336, 1024.0476356987924, 1044.6813721814767, 1045.5347370420243, 1129.1136457880689, 1230.944607492665, 6931.861362772716, 6937.514373993772, 6954.0, 6979.685914133876, 6981.82545436358, 1153.9192256542128, 1194.8745381734966, 1214.5202644955193, 1233.1552886272932, 1236.486857953957, 5577.8047768327915, 5608.9439105609235, 5678.4605462480995, 5685.658860468385, 5689.089745640677, 8799.560021998874, 8922.821543569222, 8943.463392196489, 9033.0, 9076.41003334781, 8863.911360886437, 8931.106889311146, 8936.8659470108, 8975.057618949917, 8975.102489750972, 6628.370304821035, 6803.727850886008, 6836.418904393083, 6871.312868713088, 6881.552699074544, 6512.804615861532, 6588.07766912623, 6605.372489613479, 6606.10817539626, 6631.701573429304, 7572.3942084632, 7765.456418050908, 7811.726589569338, 7813.3749300057, 7847.489913155627, 7859.646315915912, 8001.559914204542, 8005.279524842559, 8009.319207867164, 8114.391420643594, 6430.582012169194, 6478.902816457663, 6530.281669016499, 6625.138731964814, 6629.270780214269, 7145.071140751669, 7160.319769621878, 7176.928230717835, 7183.353498185188, 7206.0, 6652.068710380454, 6678.465722742266, 6684.4318232950745, 6791.185057793096, 6804.693788779417, 5743.529435214543, 6233.2208473940755, 6282.434580887742, 6318.273398559225, 6752.864942701217, 6636.800895973129, 6733.225679046972, 6734.494912881455, 6749.797506074629, 6783.0, 6108.08378743192, 6145.508359331332, 6161.353057929032, 6180.969095154495, 6190.907136393048, 6105.358937311696, 6109.511239100772, 6160.353162918008, 6161.568690191643, 6168.136460895568], "unit": "ms", "name": "mootools.html", "value": 4329.228622567117}, {"lowerIsBetter": false, "replicates": [327.9131030276976, 336.1964903879727, 338.66472192529386, 347.4267458693154, 351.21678656595793, 5799.565032622549, 5926.88146237075, 5951.642901425912, 5997.580169388139, 6028.03551431771, 5754.971225143879, 5879.588428809985, 5891.204687367204, 5904.291485021793, 5904.734286957087, 4548.5224051474615, 4603.217453032992, 4604.539546045386, 4621.5378462153685, 4628.213203755353, 4406.272964960777, 4498.842540511083, 4500.842470513533, 4617.699849509771, 4621.514740952202, 4553.726776393427, 4556.589906908378, 4561.498235194126, 4567.429071366079, 4579.0, 4583.839565615204, 4586.472555656109, 4588.678792484528, 4597.310403439494, 4608.078384323116, 4049.514058312992, 4058.391241313797, 4059.2287465381482, 4070.5318888327924, 4071.2875246831686, 5561.045017983514, 5619.072852979253, 5653.462921022497, 5656.971715141439, 5660.85847853807, 5261.289725886994, 5303.920441193385, 5321.3348331458565, 5333.679979201222, 5357.303550538405, 6234.2830574483605, 6234.407731265523, 6240.781572644981, 6303.842403939892, 6306.369363063657, 4469.195544801934, 4470.955290447087, 4471.8658440246845, 4471.888202794924, 4477.059817438342, 6413.134226879405, 6551.639659818708, 6560.245571759261, 6611.4380277676455, 6614.437772789319, 4361.193179261783, 4389.473263208435, 4404.075144219686, 4406.140802543473, 4406.471223453206, 4456.62118719906, 4458.4426946631675, 4459.44256967879, 4460.487043989918, 4461.152381047591, 5125.205593133071, 5212.296339994128, 5216.556592689664, 5220.216967454912, 5220.3735551734035, 6363.236411630634, 6395.360463953567, 6403.551751377452, 6410.423061924356, 6416.518761092937, 1575.4013474879473, 1576.6452548176799, 1577.2350410051115, 1578.763185522181, 1579.636683562787, 1060.7136073260176, 1063.0857462582173, 1063.4257500949554, 1069.3209811769427, 1090.8963648453384, 6136.969315153396, 6159.81520554384, 6163.630182188993, 6165.0, 6170.382961703794, 6300.21247344082, 6407.231132264065, 6509.414152726277, 6584.8353791155605, 6587.209534855752, 6181.196444462191, 6199.814005579839, 6206.751729930843, 6211.16149319836, 6211.16149319845, 3531.2407832316176, 3568.1614820517157, 3570.5001299818045, 3570.767900086486, 3571.8392672329805, 6622.668866556653, 6829.7268109276065, 6832.0, 6835.14560679915, 6851.794446166623, 6772.932270677329, 6777.457803375718, 6784.559003664746, 6784.864302713918, 6795.082663840417, 6753.459723222229, 6771.221309549464, 6772.492063095287, 6782.321767823179, 6785.423239024738, 6427.839304017437, 6581.934180658132, 6588.868222635616, 6593.571417857824, 6595.1096601958125, 6493.350664933469, 6497.18785151856, 6498.805035848932, 6503.869922601427, 6504.9674751625935, 6794.592324460548, 6805.61803368817, 6806.93193068063, 6813.3527314905, 6820.795376138723, 4406.867793966187, 4450.532694067077, 4485.1926653201435, 4494.595486406239, 4498.190325741398, 6534.509911756542, 6546.476281897532, 6559.0817285579105, 6564.245111812203, 6568.704408301543, 6413.0701048348665, 6419.550631455753, 6424.261209960914, 6431.807045788634, 6434.613923164625, 6240.032794916795, 6326.240851097898, 6339.397757213057, 6348.143000694847, 6394.4564712, 6241.157443745036, 6243.406876346739, 6247.5001999840815, 6260.906086408617, 6268.749250029948, 6412.294647588855, 6414.5189110815945, 6431.389018043278, 6436.452901503425, 6445.806625801233, 6150.415710507495, 6262.561620686508, 6275.403836635513, 6279.748810047729, 6288.779892703734], "unit": "ms", "name": "prototype.html", "value": 4787.335617366294}, {"lowerIsBetter": false, "replicates": [738.8300690841106, 741.773759003504, 753.7060546386907, 798.9360851131909, 802.79127426869, 13004.0, 13209.471621135142, 13260.801087983677, 13294.06941514092, 13322.533711320106, 12137.575184868532, 12237.449314780833, 12258.264504129758, 12267.938660306709, 12279.44742486588, 669.9430548403392, 671.664167916042, 673.6732684647942, 780.5082797837355, 795.4908858330673, 789.3290702902544, 795.757294025322, 801.3028665061405, 802.7471346525825, 804.4127786715701, 789.2186735132207, 831.3723139030054, 845.6997765793147, 846.3609974469298, 846.7417437681505, 693.4937495628194, 699.4963626189161, 822.5928165558028, 830.016430529821, 832.4464231286188, 613.677819144948, 614.5022531749297, 615.9784407545759, 616.3374372549528, 619.683961179797, 12129.696757581043, 12191.634250972485, 12228.938855305756, 12274.202176858566, 12313.0, 11644.883551164465, 11739.23694959825, 11740.471678774476, 12461.314627695474, 13028.54400095992, 10101.0, 10156.644517441853, 10455.790884182274, 10602.522886470128, 10647.0, 3612.1330880588735, 3628.455731640249, 3650.0327413235514, 3668.834902429397, 3822.3502004659276, 45850.0, 46256.768716156206, 46654.76672616649, 46974.0, 47119.52880471186, 9810.607575697035, 9906.306558540977, 9925.15636170919, 9973.60105595768, 9974.650887218913, 15868.761968570481, 15874.52376428709, 15892.125933073561, 15935.840641593435, 15953.840461595235, 7242.23956484572, 7292.963535182396, 7408.518446300973, 7469.0, 7605.125410577854, 3994.960050399517, 4052.3111071117983, 4065.5527891931865, 4093.488313960755, 4131.049858532554, 3203.855826487767, 3231.159898426426, 3237.206884313311, 3241.62721287055, 3244.3186930744337, 561.5760101123625, 577.566824881339, 584.290087543628, 594.0940066398776, 599.3227652752362, 625.2965413909352, 653.6013032050446, 677.9525433219627, 688.1707542411382, 712.918014428337, 8922.643094276285, 8922.910770892338, 9092.181703646704, 9106.408083474686, 9185.035571265054, 624.6720471752367, 634.463878023079, 649.8342922554813, 665.8468552233013, 680.8604236131581, 3813.637704418076, 3834.3481608126685, 4002.459667944848, 4019.8995025124023, 4119.829777115032, 55868.72065639646, 57465.71267143721, 57471.0, 57867.0, 57953.42046579564, 49689.0, 50384.74807626012, 50726.74636626793, 51502.0, 51618.22572661413, 45017.54982450199, 45585.08829823385, 45866.312005319945, 45909.7704511482, 46195.538044619796, 7916.168802275678, 7944.602769861368, 7957.173618310907, 8025.8796118059445, 8172.141925098017, 33252.83373583117, 33690.0, 33744.49383259302, 35692.0, 36081.639183607826, 45062.32406513971, 45417.0, 45624.0, 46252.07495849997, 46409.535904641874, 11081.778364432505, 11082.390468524309, 11193.27243729155, 11253.887461125283, 11412.31526108436, 11636.650900473, 11675.941620291844, 11712.765744685228, 11885.405729713308, 12388.318642474751, 11142.930754290659, 11336.319820810777, 11342.432878355885, 11359.886401136213, 11749.76500470003, 11086.279391839505, 11154.442277885912, 11240.156988225752, 11502.137339699724, 11883.346415947206, 7689.807754806175, 10750.73123171927, 11116.555337786722, 11133.498992545194, 11158.665240042812, 9806.166475849634, 9896.50517474109, 9994.450305233282, 10026.042956024088, 10129.797404052026, 9560.28297877648, 9623.514397383822, 9631.807363852824, 9884.209263258777, 9953.552090155816], "unit": "ms", "name": "yui.html", "value": 6184.857377261757}], "name": "dromaeo_css", "value": 6906.893953363436}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 106.0, 111.0, 111.0, 111.0, 101.0, 110.0, 111.0, 107.0], "unit": "ms", "name": "ai-astar", "value": 108.8}, {"lowerIsBetter": true, "replicates": [146.0, 125.0, 156.0, 159.0, 124.0, 150.0, 145.0, 125.0, 157.0, 126.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.3}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 160.0, 160.0, 161.0, 162.0, 159.0, 164.0, 160.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 87.0, 91.0, 72.0, 71.0, 72.0, 113.0, 90.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 81.0}, {"lowerIsBetter": true, "replicates": [90.0, 90.0, 135.0, 89.0, 91.0, 90.0, 132.0, 90.0, 91.0, 129.0], "unit": "ms", "name": "audio-oscillator", "value": 102.7}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [60.0, 59.0, 60.0, 59.0, 60.0, 60.0, 60.0, 69.0, 57.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 60.3}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 70.0, 69.0, 70.0, 69.0, 69.0, 69.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 85.0, 84.0, 84.0, 86.0, 93.0, 84.0, 84.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.2}, {"lowerIsBetter": true, "replicates": [122.0, 123.0, 123.0, 120.0, 129.0, 120.0, 116.0, 124.0, 116.0, 117.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.0}, {"lowerIsBetter": true, "replicates": [138.0, 140.0, 151.0, 152.0, 151.0, 141.0, 143.0, 150.0, 146.0, 141.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.3}, {"lowerIsBetter": true, "replicates": [65.0, 69.0, 67.0, 67.0, 65.0, 67.0, 66.0, 67.0, 65.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.4}], "name": "kraken", "value": 1492.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.83992835043153], "unit": "score", "name": "Richards", "value": 216.78958200000002}, {"lowerIsBetter": false, "replicates": [194.1370607649], "unit": "score", "name": "DeltaBlue", "value": 340.5738179999999}, {"lowerIsBetter": false, "replicates": [284.57598178713715], "unit": "score", "name": "Encrypt", "value": 935.3600340000003}, {"lowerIsBetter": false, "replicates": [5040.201005025126], "unit": "score", "name": "Decrypt", "value": 52.81158424725827}, {"lowerIsBetter": false, "replicates": [1107.4197120708748], "unit": "score", "name": "RayTrace", "value": 668.2100670000003}, {"lowerIsBetter": false, "replicates": [782.4726134585289], "unit": "score", "name": "Earley", "value": 851.7397139999999}, {"lowerIsBetter": false, "replicates": [11916.666666666666], "unit": "score", "name": "Boyer", "value": 55.926965034964994}, {"lowerIsBetter": false, "replicates": [25666.666666666668], "unit": "score", "name": "RegExp", "value": 35.49292207792205}, {"lowerIsBetter": false, "replicates": [681.4332247557003], "unit": "score", "name": "Splay", "value": 119.58765296367116}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20874.903004257074}]} 19:16:40 INFO - RETURN: dromaeo_css: 6906.90 19:16:40 INFO - RETURN: kraken: 1492.00 19:16:40 INFO - RETURN: v8_7: 20874.90 19:16:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20874.90"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1492.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6906.90"}}} 19:16:40 INFO - Return code: 0 19:16:40 INFO - # TBPL SUCCESS # 19:16:40 INFO - Running post-action listener: _resource_record_post_action 19:16:40 INFO - Running post-run listener: _resource_record_post_run 19:16:41 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 20480; Write bytes: 331280384; Read time: 52; Write time: 174400 19:16:41 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 61153280; Read time: 0; Write time: 30112 19:16:41 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 20480; Write bytes: 270127104; Read time: 52; Write time: 144288 19:16:41 INFO - Running post-run listener: _upload_blobber_files 19:16:41 INFO - Blob upload gear active. 19:16:41 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 19:16:41 INFO - Copying logs to upload dir... 19:16:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1261.904720 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-11-21 19:16:41.090483) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-21 19:16:41.093606) ========= 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=e10134013339c31d8d0c4708000001d6-1448148779.491272-1737342252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/n3HXoXWzQfWKvlReew0C1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010022 build_url: 'https://queue.taskcluster.net/v1/task/n3HXoXWzQfWKvlReew0C1A/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-21 19:16:41.144079) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 19:16:41.144409) ========= 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=e10134013339c31d8d0c4708000001d6-1448148779.491272-1737342252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004555 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 19:16:41.193914) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-21 19:16:41.194239) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-21 19:16:41.194530) ========= ========= Total master_lag: 0.20 =========