builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1447815381.99 results: success (0) buildid: 20151117173015 builduid: 012ecbf6ee8c498ebaf4cf1692b614a7 revision: 8e712e56faf8ef12537ad604f38bca4f06665a7b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:21.989578) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:21.990514) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:21.991198) ========= 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=a65b340e283ce644d68cb24e000001c9-1447815148.607166-20276609 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006693 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.014003) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.014319) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.027981) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.028294) ========= 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=a65b340e283ce644d68cb24e000001c9-1447815148.607166-20276609 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004703 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.080340) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.081023) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.082286) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.083496) ========= 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=a65b340e283ce644d68cb24e000001c9-1447815148.607166-20276609 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-17 18:56:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.8M=0s 2015-11-17 18:56:22 (38.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179787 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.278039) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.278399) ========= 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=a65b340e283ce644d68cb24e000001c9-1447815148.607166-20276609 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015149 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.328883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.329257) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8e712e56faf8ef12537ad604f38bca4f06665a7b --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 8e712e56faf8ef12537ad604f38bca4f06665a7b --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=a65b340e283ce644d68cb24e000001c9-1447815148.607166-20276609 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-17 18:56:22,427 truncating revision to first 12 chars 2015-11-17 18:56:22,427 Setting DEBUG logging. 2015-11-17 18:56:22,427 attempt 1/10 2015-11-17 18:56:22,427 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8e712e56faf8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 18:56:22,670 unpacking tar archive at: fx-team-8e712e56faf8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.517994 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.863714) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.864114) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.874553) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.874935) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.875481) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2015-11-17 18:56:22.875908) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a65b340e283ce644d68cb24e000001c9-1447815148.607166-20276609 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:56:23 INFO - MultiFileLogger online at 20151117 18:56:23 in /builds/slave/test-pgo 18:56:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:56:23 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:56:23 INFO - {'append_to_log': False, 18:56:23 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:56:23 INFO - 'blob_upload_branch': 'Fx-Team', 18:56:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:56:23 INFO - 'branch': 'Fx-Team', 18:56:23 INFO - 'buildbot_json_path': 'buildprops.json', 18:56:23 INFO - 'config_files': ('talos/linux_config.py',), 18:56:23 INFO - 'default_actions': ('clobber', 18:56:23 INFO - 'read-buildbot-config', 18:56:23 INFO - 'download-and-extract', 18:56:23 INFO - 'populate-webroot', 18:56:23 INFO - 'create-virtualenv', 18:56:23 INFO - 'install', 18:56:23 INFO - 'run-tests'), 18:56:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:56:23 INFO - 'download_minidump_stackwalk': True, 18:56:23 INFO - 'download_symbols': 'ondemand', 18:56:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:56:23 INFO - 'tooltool.py': '/tools/tooltool.py', 18:56:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:56:23 INFO - '/tools/misc-python/virtualenv.py')}, 18:56:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:56:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:56:23 INFO - 'installer_path': 'installer.exe', 18:56:23 INFO - 'log_level': 'info', 18:56:23 INFO - 'log_name': 'talos', 18:56:23 INFO - 'log_to_console': True, 18:56:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:56:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:56:23 INFO - 'opt_config_files': (), 18:56:23 INFO - 'pip_index': False, 18:56:23 INFO - 'sps_profile': False, 18:56:23 INFO - 'sps_profile_interval': 0, 18:56:23 INFO - 'suite': 'dromaeojs', 18:56:23 INFO - 'system_bits': '64', 18:56:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:56:23 INFO - 'title': 'talos-linux64-ix-026', 18:56:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:56:23 INFO - 'use_talos_json': True, 18:56:23 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:56:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:56:23 INFO - 'work_dir': 'build'} 18:56:23 INFO - ##### 18:56:23 INFO - ##### Running clobber step. 18:56:23 INFO - ##### 18:56:23 INFO - Running pre-action listener: _resource_record_pre_action 18:56:23 INFO - Running main action method: clobber 18:56:23 INFO - rmtree: /builds/slave/test-pgo/build 18:56:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:56:23 INFO - Running post-action listener: _resource_record_post_action 18:56:23 INFO - ##### 18:56:23 INFO - ##### Running read-buildbot-config step. 18:56:23 INFO - ##### 18:56:23 INFO - Running pre-action listener: _resource_record_pre_action 18:56:23 INFO - Running main action method: read_buildbot_config 18:56:23 INFO - Using buildbot properties: 18:56:23 INFO - { 18:56:23 INFO - "properties": { 18:56:23 INFO - "buildnumber": 495, 18:56:23 INFO - "product": "firefox", 18:56:23 INFO - "script_repo_revision": "production", 18:56:23 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:56:23 INFO - "repository": "", 18:56:23 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 18:56:23 INFO - "buildid": "20151117173015", 18:56:23 INFO - "slavename": "talos-linux64-ix-026", 18:56:23 INFO - "pgo_build": "True", 18:56:23 INFO - "basedir": "/builds/slave/test-pgo", 18:56:23 INFO - "project": "", 18:56:23 INFO - "platform": "ubuntu64_hw", 18:56:23 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:56:23 INFO - "slavebuilddir": "test", 18:56:23 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 18:56:23 INFO - "branch": "fx-team", 18:56:23 INFO - "repo_path": "integration/fx-team", 18:56:23 INFO - "stage_platform": "linux64-pgo", 18:56:23 INFO - "builduid": "012ecbf6ee8c498ebaf4cf1692b614a7", 18:56:23 INFO - "revision": "8e712e56faf8ef12537ad604f38bca4f06665a7b" 18:56:23 INFO - }, 18:56:23 INFO - "sourcestamp": { 18:56:23 INFO - "repository": "", 18:56:23 INFO - "hasPatch": false, 18:56:23 INFO - "project": "", 18:56:23 INFO - "branch": "fx-team-linux64-pgo-talos", 18:56:23 INFO - "changes": [ 18:56:23 INFO - { 18:56:23 INFO - "category": null, 18:56:23 INFO - "files": [ 18:56:23 INFO - { 18:56:23 INFO - "url": null, 18:56:23 INFO - "name": "https://queue.taskcluster.net/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 18:56:23 INFO - } 18:56:23 INFO - ], 18:56:23 INFO - "repository": "", 18:56:23 INFO - "rev": "8e712e56faf8ef12537ad604f38bca4f06665a7b", 18:56:23 INFO - "who": "sendchange", 18:56:23 INFO - "when": 1447815318, 18:56:23 INFO - "number": 6675607, 18:56:23 INFO - "comments": "", 18:56:23 INFO - "project": "", 18:56:23 INFO - "at": "Tue 17 Nov 2015 18:55:18", 18:56:23 INFO - "branch": "fx-team-linux64-pgo-talos", 18:56:23 INFO - "revlink": "", 18:56:23 INFO - "properties": [ 18:56:23 INFO - [ 18:56:23 INFO - "buildid", 18:56:23 INFO - "20151117173015", 18:56:23 INFO - "Change" 18:56:23 INFO - ], 18:56:23 INFO - [ 18:56:23 INFO - "builduid", 18:56:23 INFO - "012ecbf6ee8c498ebaf4cf1692b614a7", 18:56:23 INFO - "Change" 18:56:23 INFO - ], 18:56:23 INFO - [ 18:56:23 INFO - "pgo_build", 18:56:23 INFO - "True", 18:56:23 INFO - "Change" 18:56:23 INFO - ] 18:56:23 INFO - ], 18:56:23 INFO - "revision": "8e712e56faf8ef12537ad604f38bca4f06665a7b" 18:56:23 INFO - } 18:56:23 INFO - ], 18:56:23 INFO - "revision": "8e712e56faf8ef12537ad604f38bca4f06665a7b" 18:56:23 INFO - } 18:56:23 INFO - } 18:56:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 18:56:23 INFO - Running post-action listener: _resource_record_post_action 18:56:23 INFO - ##### 18:56:23 INFO - ##### Running download-and-extract step. 18:56:23 INFO - ##### 18:56:23 INFO - Running pre-action listener: _resource_record_pre_action 18:56:23 INFO - Running main action method: download_and_extract 18:56:23 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:56:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:23 INFO - https://queue.taskcluster.net/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:56:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/test_packages.json 18:56:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/test_packages.json 18:56:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 18:56:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 18:56:24 INFO - Downloaded 1302 bytes. 18:56:24 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 18:56:24 INFO - Using the following test package requirements: 18:56:24 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:56:24 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:56:24 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:56:24 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:56:24 INFO - u'jsshell-linux-x86_64.zip'], 18:56:24 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:56:24 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:56:24 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:56:24 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:56:24 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:56:24 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:56:24 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:56:24 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:56:24 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:56:24 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:56:24 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:56:24 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:56:24 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:56:24 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:24 INFO - https://queue.taskcluster.net/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:56:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:56:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:56:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/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:56:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/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:56:25 INFO - Downloaded 22461291 bytes. 18:56:25 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:56:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:56:25 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:56:27 INFO - Return code: 0 18:56:27 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: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 - https://queue.taskcluster.net/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:56:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:56:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:56:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/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:56:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/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:56:28 INFO - Downloaded 22461291 bytes. 18:56:28 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:56:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:56:28 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:56:29 INFO - Return code: 0 18:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:29 INFO - https://queue.taskcluster.net/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:56:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:56:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:56:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/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:56:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/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:56:30 INFO - Downloaded 11131693 bytes. 18:56:30 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:56:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:56:30 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:56:31 INFO - Return code: 0 18:56:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:31 INFO - https://queue.taskcluster.net/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:56:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:56:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:56:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/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:56:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/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:56:32 INFO - Downloaded 57195352 bytes. 18:56:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:56:32 INFO - mkdir: /builds/slave/test-pgo/properties 18:56:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:56:32 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:56:32 INFO - Contents: 18:56:32 INFO - build_url:https://queue.taskcluster.net/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:56:32 INFO - Running post-action listener: _resource_record_post_action 18:56:32 INFO - Running post-action listener: set_extra_try_arguments 18:56:32 INFO - ##### 18:56:32 INFO - ##### Running populate-webroot step. 18:56:32 INFO - ##### 18:56:32 INFO - Running pre-action listener: _resource_record_pre_action 18:56:32 INFO - Running main action method: populate_webroot 18:56:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:56:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:56:32 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:56:32 INFO - '../fennec_ids.txt'], 18:56:32 INFO - 'tests': ['tcheck2']}, 18:56:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:56:32 INFO - '--tppagecycles', 18:56:32 INFO - '7'], 18:56:32 INFO - 'tests': ['tsvgm']}}, 18:56:32 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:56:32 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:56:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:56:32 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:56:32 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:56:32 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:56:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:56:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:56:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:56:32 INFO - 'talos_options': ['--e10s'], 18:56:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:56:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:56:32 INFO - 'tests': ['damp', 'tps']}, 18:56:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:56:32 INFO - 'talos_options': ['--e10s'], 18:56:32 INFO - 'tests': ['damp', 'tps']}, 18:56:32 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:56:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:56:32 INFO - 'other': {'tests': ['a11yr', 18:56:32 INFO - 'ts_paint', 18:56:32 INFO - 'tpaint', 18:56:32 INFO - 'sessionrestore', 18:56:32 INFO - 'sessionrestore_no_auto_restore']}, 18:56:32 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:56:32 INFO - 'tests': ['a11yr', 18:56:32 INFO - 'ts_paint', 18:56:32 INFO - 'tpaint', 18:56:32 INFO - 'sessionrestore', 18:56:32 INFO - 'sessionrestore_no_auto_restore']}, 18:56:32 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:56:32 INFO - 'tests': ['a11yr', 18:56:32 INFO - 'ts_paint', 18:56:32 INFO - 'tpaint', 18:56:32 INFO - 'sessionrestore', 18:56:32 INFO - 'sessionrestore_no_auto_restore']}, 18:56:32 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:56:32 INFO - 'tests': ['a11yr', 18:56:32 INFO - 'ts_paint', 18:56:32 INFO - 'tpaint', 18:56:32 INFO - 'sessionrestore', 18:56:32 INFO - 'sessionrestore_no_auto_restore']}, 18:56:32 INFO - 'other_l64': {'tests': ['a11yr', 18:56:32 INFO - 'ts_paint', 18:56:32 INFO - 'tpaint', 18:56:32 INFO - 'sessionrestore', 18:56:32 INFO - 'sessionrestore_no_auto_restore']}, 18:56:32 INFO - 'other_nol64': {'tests': ['a11yr', 18:56:32 INFO - 'ts_paint', 18:56:32 INFO - 'tpaint', 18:56:32 INFO - 'sessionrestore', 18:56:32 INFO - 'sessionrestore_no_auto_restore']}, 18:56:32 INFO - 'svgr': {'tests': ['tsvgx', 18:56:32 INFO - 'tsvgr_opacity', 18:56:32 INFO - 'tart', 18:56:32 INFO - 'tscrollx', 18:56:32 INFO - 'cart']}, 18:56:32 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:56:32 INFO - 'tests': ['tsvgx', 18:56:32 INFO - 'tsvgr_opacity', 18:56:32 INFO - 'tart', 18:56:32 INFO - 'tscrollx', 18:56:32 INFO - 'cart']}, 18:56:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:56:32 INFO - 'tests': ['tp5o']}, 18:56:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:56:32 INFO - 'talos_options': ['--e10s'], 18:56:32 INFO - 'tests': ['tp5o']}, 18:56:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:56:32 INFO - 'talos_options': ['--xperf_path', 18:56:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:56:32 INFO - 'tests': ['tp5n']}, 18:56:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:56:32 INFO - 'talos_options': ['--e10s', 18:56:32 INFO - '--xperf_path', 18:56:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:56:32 INFO - 'tests': ['tp5n']}}, 18:56:32 INFO - 'talos.zip': {'path': '', 18:56:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:56:32 INFO - Running post-action listener: _resource_record_post_action 18:56:32 INFO - ##### 18:56:32 INFO - ##### Running create-virtualenv step. 18:56:32 INFO - ##### 18:56:32 INFO - Running pre-action listener: _resource_record_pre_action 18:56:32 INFO - Running main action method: create_virtualenv 18:56:32 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:56:32 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:56:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:56:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:56:32 INFO - Using real prefix '/usr' 18:56:32 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:56:33 INFO - Installing distribute.............................................................................................................................................................................................done. 18:56:35 INFO - Installing pip.................done. 18:56:35 INFO - Return code: 0 18:56:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:35 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1884454c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29956c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a566e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8ca90>, '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 0x2adef70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2adf2e0>, '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': 'a65b340e283ce644d68cb24e000001c9-1447815148.607166-20276609', '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:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 18:56:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:56:35 INFO - Using env: {'DISPLAY': ':0', 18:56:35 INFO - 'HOME': '/home/cltbld', 18:56:35 INFO - 'LANG': 'en_US.UTF-8', 18:56:35 INFO - 'LANGUAGE': 'en_US:en', 18:56:35 INFO - 'LOGNAME': 'cltbld', 18:56:35 INFO - 'MAIL': '/var/mail/cltbld', 18:56:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:35 INFO - 'MOZ_NO_REMOTE': '1', 18:56:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:35 INFO - 'NO_EM_RESTART': '1', 18:56:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:56:35 INFO - 'PWD': '/builds/slave/test-pgo', 18:56:35 INFO - 'SHELL': '/bin/bash', 18:56:35 INFO - 'SHLVL': '1', 18:56:35 INFO - 'TERM': 'linux', 18:56:35 INFO - 'TMOUT': '86400', 18:56:35 INFO - 'USER': 'cltbld', 18:56:35 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1447815148.607166-20276609', 18:56:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:35 INFO - '_': '/tools/buildbot/bin/python'} 18:56:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:35 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:56:35 INFO - Cleaning up... 18:56:35 INFO - Return code: 0 18:56:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:35 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1884454c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29956c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a566e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8ca90>, '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 0x2adef70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2adf2e0>, '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': 'a65b340e283ce644d68cb24e000001c9-1447815148.607166-20276609', '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:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 18:56:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:56:35 INFO - Using env: {'DISPLAY': ':0', 18:56:35 INFO - 'HOME': '/home/cltbld', 18:56:35 INFO - 'LANG': 'en_US.UTF-8', 18:56:35 INFO - 'LANGUAGE': 'en_US:en', 18:56:35 INFO - 'LOGNAME': 'cltbld', 18:56:35 INFO - 'MAIL': '/var/mail/cltbld', 18:56:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:35 INFO - 'MOZ_NO_REMOTE': '1', 18:56:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:35 INFO - 'NO_EM_RESTART': '1', 18:56:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:56:35 INFO - 'PWD': '/builds/slave/test-pgo', 18:56:35 INFO - 'SHELL': '/bin/bash', 18:56:35 INFO - 'SHLVL': '1', 18:56:35 INFO - 'TERM': 'linux', 18:56:35 INFO - 'TMOUT': '86400', 18:56:35 INFO - 'USER': 'cltbld', 18:56:35 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1447815148.607166-20276609', 18:56:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:35 INFO - '_': '/tools/buildbot/bin/python'} 18:56:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:35 INFO - Downloading/unpacking psutil>=0.7.1 18:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:37 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 18:56:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:56:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:56:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:56:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:56:37 INFO - Installing collected packages: psutil 18:56:37 INFO - Running setup.py install for psutil 18:56:37 INFO - building 'psutil._psutil_linux' extension 18:56:37 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:56:37 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:56:37 INFO - building 'psutil._psutil_posix' extension 18:56:37 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:56:37 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:56:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:56:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:56:37 INFO - Successfully installed psutil 18:56:37 INFO - Cleaning up... 18:56:37 INFO - Return code: 0 18:56:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:37 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 0x7f1884454c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29956c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a566e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8ca90>, '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 0x2adef70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2adf2e0>, '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': 'a65b340e283ce644d68cb24e000001c9-1447815148.607166-20276609', '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:37 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:37 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:37 INFO - Using env: {'DISPLAY': ':0', 18:56:37 INFO - 'HOME': '/home/cltbld', 18:56:37 INFO - 'LANG': 'en_US.UTF-8', 18:56:37 INFO - 'LANGUAGE': 'en_US:en', 18:56:37 INFO - 'LOGNAME': 'cltbld', 18:56:37 INFO - 'MAIL': '/var/mail/cltbld', 18:56:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:37 INFO - 'MOZ_NO_REMOTE': '1', 18:56:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:37 INFO - 'NO_EM_RESTART': '1', 18:56:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:56:37 INFO - 'PWD': '/builds/slave/test-pgo', 18:56:37 INFO - 'SHELL': '/bin/bash', 18:56:37 INFO - 'SHLVL': '1', 18:56:37 INFO - 'TERM': 'linux', 18:56:37 INFO - 'TMOUT': '86400', 18:56:37 INFO - 'USER': 'cltbld', 18:56:37 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1447815148.607166-20276609', 18:56:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:37 INFO - '_': '/tools/buildbot/bin/python'} 18:56:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:56:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:56:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:56:39 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:39 INFO - Installing collected packages: mozsystemmonitor 18:56:39 INFO - Running setup.py install for mozsystemmonitor 18:56:39 INFO - Successfully installed mozsystemmonitor 18:56:39 INFO - Cleaning up... 18:56:39 INFO - Return code: 0 18:56:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:56:39 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:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:39 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:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:39 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 0x7f1884454c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29956c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a566e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8ca90>, '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 0x2adef70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2adf2e0>, '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': 'a65b340e283ce644d68cb24e000001c9-1447815148.607166-20276609', '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:39 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:39 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:39 INFO - Using env: {'DISPLAY': ':0', 18:56:39 INFO - 'HOME': '/home/cltbld', 18:56:39 INFO - 'LANG': 'en_US.UTF-8', 18:56:39 INFO - 'LANGUAGE': 'en_US:en', 18:56:39 INFO - 'LOGNAME': 'cltbld', 18:56:39 INFO - 'MAIL': '/var/mail/cltbld', 18:56:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:39 INFO - 'MOZ_NO_REMOTE': '1', 18:56:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:39 INFO - 'NO_EM_RESTART': '1', 18:56:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:56:39 INFO - 'PWD': '/builds/slave/test-pgo', 18:56:39 INFO - 'SHELL': '/bin/bash', 18:56:39 INFO - 'SHLVL': '1', 18:56:39 INFO - 'TERM': 'linux', 18:56:39 INFO - 'TMOUT': '86400', 18:56:39 INFO - 'USER': 'cltbld', 18:56:39 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1447815148.607166-20276609', 18:56:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:39 INFO - '_': '/tools/buildbot/bin/python'} 18:56:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:40 INFO - Downloading/unpacking blobuploader==1.2.4 18:56:40 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:40 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:40 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:40 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:40 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:40 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:41 INFO - Downloading blobuploader-1.2.4.tar.gz 18:56:41 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:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:56:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:56:41 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:41 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:41 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:41 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:41 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:41 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:41 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:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:56:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:56:42 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:42 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:42 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:42 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:42 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:42 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:42 INFO - Downloading docopt-0.6.1.tar.gz 18:56:42 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:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:56:42 INFO - Installing collected packages: blobuploader, requests, docopt 18:56:42 INFO - Running setup.py install for blobuploader 18:56:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:56:42 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:56:42 INFO - Running setup.py install for requests 18:56:42 INFO - Running setup.py install for docopt 18:56:42 INFO - Successfully installed blobuploader requests docopt 18:56:42 INFO - Cleaning up... 18:56:42 INFO - Return code: 0 18:56:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:42 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 0x7f1884454c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29956c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a566e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8ca90>, '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 0x2adef70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2adf2e0>, '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': 'a65b340e283ce644d68cb24e000001c9-1447815148.607166-20276609', '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:42 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:42 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:42 INFO - Using env: {'DISPLAY': ':0', 18:56:42 INFO - 'HOME': '/home/cltbld', 18:56:42 INFO - 'LANG': 'en_US.UTF-8', 18:56:42 INFO - 'LANGUAGE': 'en_US:en', 18:56:42 INFO - 'LOGNAME': 'cltbld', 18:56:42 INFO - 'MAIL': '/var/mail/cltbld', 18:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:42 INFO - 'MOZ_NO_REMOTE': '1', 18:56:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:42 INFO - 'NO_EM_RESTART': '1', 18:56:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:56:42 INFO - 'PWD': '/builds/slave/test-pgo', 18:56:42 INFO - 'SHELL': '/bin/bash', 18:56:42 INFO - 'SHLVL': '1', 18:56:42 INFO - 'TERM': 'linux', 18:56:42 INFO - 'TMOUT': '86400', 18:56:42 INFO - 'USER': 'cltbld', 18:56:42 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1447815148.607166-20276609', 18:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:42 INFO - '_': '/tools/buildbot/bin/python'} 18:56:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:56:43 INFO - Running setup.py (path:/tmp/pip-q9MkhN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:56:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:56:43 INFO - Running setup.py (path:/tmp/pip-lIfJ5u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:56:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:56:43 INFO - Running setup.py (path:/tmp/pip-KRvX4D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:56:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:56:43 INFO - Running setup.py (path:/tmp/pip-MDIEP5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:56:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:56:43 INFO - Running setup.py (path:/tmp/pip-wrJZ6I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:56:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:56:43 INFO - Running setup.py (path:/tmp/pip-60G0jY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:56:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:56:43 INFO - Running setup.py (path:/tmp/pip-yr3hlS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:56:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:56:43 INFO - Running setup.py (path:/tmp/pip-wk08xT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:56:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:56:43 INFO - Running setup.py (path:/tmp/pip-CRgRfs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:56:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:56:43 INFO - Running setup.py (path:/tmp/pip-T5xlrO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:56:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:56:43 INFO - Running setup.py (path:/tmp/pip-KjA5cX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:56:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:56:43 INFO - Running setup.py (path:/tmp/pip-DwupyV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:56:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:56:44 INFO - Running setup.py (path:/tmp/pip-pVejmd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:56:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:56:44 INFO - Running setup.py (path:/tmp/pip-LLXgU4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:56:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:56:44 INFO - Running setup.py (path:/tmp/pip-UP1q0V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:56:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:56:44 INFO - Running setup.py (path:/tmp/pip-CaZpFa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:56:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:56:44 INFO - Running setup.py (path:/tmp/pip-ABVcQW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:56:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:56:44 INFO - Running setup.py install for manifestparser 18:56:44 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:56:44 INFO - Running setup.py install for mozcrash 18:56:44 INFO - Running setup.py install for mozdebug 18:56:44 INFO - Running setup.py install for mozdevice 18:56:44 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:56:44 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:56:44 INFO - Running setup.py install for mozfile 18:56:44 INFO - Running setup.py install for mozhttpd 18:56:45 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:56:45 INFO - Running setup.py install for mozinfo 18:56:45 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:56:45 INFO - Running setup.py install for mozInstall 18:56:45 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:56:45 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:56:45 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:56:45 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:56:45 INFO - Running setup.py install for mozleak 18:56:45 INFO - Running setup.py install for mozlog 18:56:45 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:56:45 INFO - Running setup.py install for moznetwork 18:56:45 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:56:45 INFO - Running setup.py install for mozprocess 18:56:45 INFO - Running setup.py install for mozprofile 18:56:45 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:56:45 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:56:45 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:56:45 INFO - Running setup.py install for mozrunner 18:56:45 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:56:45 INFO - Running setup.py install for mozscreenshot 18:56:45 INFO - Running setup.py install for moztest 18:56:46 INFO - Running setup.py install for mozversion 18:56:46 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:56:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:56:46 INFO - Cleaning up... 18:56:46 INFO - Return code: 0 18:56:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:56:46 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:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:46 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:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:46 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 0x7f1884454c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29956c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a566e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8ca90>, '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 0x2adef70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2adf2e0>, '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': 'a65b340e283ce644d68cb24e000001c9-1447815148.607166-20276609', '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:46 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:46 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:46 INFO - Using env: {'DISPLAY': ':0', 18:56:46 INFO - 'HOME': '/home/cltbld', 18:56:46 INFO - 'LANG': 'en_US.UTF-8', 18:56:46 INFO - 'LANGUAGE': 'en_US:en', 18:56:46 INFO - 'LOGNAME': 'cltbld', 18:56:46 INFO - 'MAIL': '/var/mail/cltbld', 18:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:46 INFO - 'MOZ_NO_REMOTE': '1', 18:56:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:46 INFO - 'NO_EM_RESTART': '1', 18:56:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:56:46 INFO - 'PWD': '/builds/slave/test-pgo', 18:56:46 INFO - 'SHELL': '/bin/bash', 18:56:46 INFO - 'SHLVL': '1', 18:56:46 INFO - 'TERM': 'linux', 18:56:46 INFO - 'TMOUT': '86400', 18:56:46 INFO - 'USER': 'cltbld', 18:56:46 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1447815148.607166-20276609', 18:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:46 INFO - '_': '/tools/buildbot/bin/python'} 18:56:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:56:46 INFO - Running setup.py (path:/tmp/pip-NtPIC4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:56:46 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:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:56:46 INFO - Running setup.py (path:/tmp/pip-d6usgC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:56:46 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:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:56:46 INFO - Running setup.py (path:/tmp/pip-d0VmdC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:56:46 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:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:56:46 INFO - Running setup.py (path:/tmp/pip-STBJ6x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:56:46 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:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:56:46 INFO - Running setup.py (path:/tmp/pip-IxBDtp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:56:46 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:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:56:46 INFO - Running setup.py (path:/tmp/pip-bTi7e7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:56:46 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:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:56:46 INFO - Running setup.py (path:/tmp/pip-uyN6Mh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:56:46 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:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:56:46 INFO - Running setup.py (path:/tmp/pip-ZxEhGx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:56:46 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:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:56:46 INFO - Running setup.py (path:/tmp/pip-7Er41z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:56:47 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:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:56:47 INFO - Running setup.py (path:/tmp/pip-dumcls-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:56:47 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:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:56:47 INFO - Running setup.py (path:/tmp/pip-mU48gK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:56:47 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:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:56:47 INFO - Running setup.py (path:/tmp/pip-oCk7rc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:56:47 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:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:56:47 INFO - Running setup.py (path:/tmp/pip-CgbIqf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:56:47 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:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:56:47 INFO - Running setup.py (path:/tmp/pip-P3FPUH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:56:47 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:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:56:47 INFO - Running setup.py (path:/tmp/pip-6KULCT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:56:47 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:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:56:47 INFO - Running setup.py (path:/tmp/pip-xQ2gU9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:56:47 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:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:56:47 INFO - Running setup.py (path:/tmp/pip-7CpPye-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:56:47 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:47 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:47 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:47 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:47 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:47 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:47 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:47 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:47 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:47 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:47 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:47 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:47 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:49 INFO - Downloading blessings-1.5.1.tar.gz 18:56:49 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:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:56:49 INFO - Installing collected packages: blessings 18:56:49 INFO - Running setup.py install for blessings 18:56:49 INFO - Successfully installed blessings 18:56:49 INFO - Cleaning up... 18:56:49 INFO - Return code: 0 18:56:49 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:56:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:56:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:56:49 INFO - Reading from file tmpfile_stdout 18:56:49 INFO - Current package versions: 18:56:49 INFO - argparse == 1.2.1 18:56:49 INFO - blessings == 1.5.1 18:56:49 INFO - blobuploader == 1.2.4 18:56:49 INFO - docopt == 0.6.1 18:56:49 INFO - manifestparser == 1.1 18:56:49 INFO - mozInstall == 1.12 18:56:49 INFO - mozcrash == 0.16 18:56:49 INFO - mozdebug == 0.1 18:56:49 INFO - mozdevice == 0.47 18:56:49 INFO - mozfile == 1.2 18:56:49 INFO - mozhttpd == 0.7 18:56:49 INFO - mozinfo == 0.9 18:56:49 INFO - mozleak == 0.1 18:56:49 INFO - mozlog == 3.0 18:56:49 INFO - moznetwork == 0.27 18:56:49 INFO - mozprocess == 0.22 18:56:49 INFO - mozprofile == 0.27 18:56:49 INFO - mozrunner == 6.11 18:56:49 INFO - mozscreenshot == 0.1 18:56:49 INFO - mozsystemmonitor == 0.0 18:56:49 INFO - moztest == 0.7 18:56:49 INFO - mozversion == 1.4 18:56:49 INFO - psutil == 3.1.1 18:56:49 INFO - requests == 1.2.3 18:56:49 INFO - wsgiref == 0.1.2 18:56:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:49 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 0x7f1884454c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29956c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a566e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8ca90>, '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 0x2adef70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2adf2e0>, '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': 'a65b340e283ce644d68cb24e000001c9-1447815148.607166-20276609', '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:49 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:49 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:49 INFO - Using env: {'DISPLAY': ':0', 18:56:49 INFO - 'HOME': '/home/cltbld', 18:56:49 INFO - 'LANG': 'en_US.UTF-8', 18:56:49 INFO - 'LANGUAGE': 'en_US:en', 18:56:49 INFO - 'LOGNAME': 'cltbld', 18:56:49 INFO - 'MAIL': '/var/mail/cltbld', 18:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:49 INFO - 'MOZ_NO_REMOTE': '1', 18:56:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:49 INFO - 'NO_EM_RESTART': '1', 18:56:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:56:49 INFO - 'PWD': '/builds/slave/test-pgo', 18:56:49 INFO - 'SHELL': '/bin/bash', 18:56:49 INFO - 'SHLVL': '1', 18:56:49 INFO - 'TERM': 'linux', 18:56:49 INFO - 'TMOUT': '86400', 18:56:49 INFO - 'USER': 'cltbld', 18:56:49 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1447815148.607166-20276609', 18:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:49 INFO - '_': '/tools/buildbot/bin/python'} 18:56:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:49 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:49 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:49 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:49 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:49 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:49 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:49 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:49 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:49 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:49 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:49 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:49 INFO - Cleaning up... 18:56:49 INFO - Return code: 0 18:56:49 INFO - Running post-action listener: _resource_record_post_action 18:56:49 INFO - Running post-action listener: _start_resource_monitoring 18:56:49 INFO - Starting resource monitoring. 18:56:49 INFO - ##### 18:56:49 INFO - ##### Running install step. 18:56:49 INFO - ##### 18:56:49 INFO - Running pre-action listener: _resource_record_pre_action 18:56:49 INFO - Running main action method: install 18:56:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:56:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:56:50 INFO - Reading from file tmpfile_stdout 18:56:50 INFO - Detecting whether we're running mozinstall >=1.0... 18:56:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:56:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:56:50 INFO - Reading from file tmpfile_stdout 18:56:50 INFO - Output received: 18:56:50 INFO - Usage: mozinstall [options] installer 18:56:50 INFO - Options: 18:56:50 INFO - -h, --help show this help message and exit 18:56:50 INFO - -d DEST, --destination=DEST 18:56:50 INFO - Directory to install application into. [default: 18:56:50 INFO - "/builds/slave/test-pgo"] 18:56:50 INFO - --app=APP Application being installed. [default: firefox] 18:56:50 INFO - mkdir: /builds/slave/test-pgo/build/application 18:56:50 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:50 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:57:05 INFO - Reading from file tmpfile_stdout 18:57:05 INFO - Output received: 18:57:05 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:57:05 INFO - Running post-action listener: _resource_record_post_action 18:57:05 INFO - ##### 18:57:05 INFO - ##### Running run-tests step. 18:57:05 INFO - ##### 18:57:05 INFO - Running pre-action listener: _resource_record_pre_action 18:57:05 INFO - Running main action method: run_tests 18:57:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:57:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:57:05 INFO - Python 2.7.3 18:57:05 INFO - Return code: 0 18:57:05 INFO - grabbing minidump binary from tooltool 18:57: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:57:05 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 0x2a8ca90>, '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 0x2adef70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2adf2e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:57:05 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:57:05 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:57:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:57:05 INFO - Return code: 0 18:57:05 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:57:05 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:57:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:57:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:57:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:57:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 18:57:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost 18:57:05 INFO - Using env: {'DISPLAY': ':0', 18:57:05 INFO - 'HOME': '/home/cltbld', 18:57:05 INFO - 'LANG': 'en_US.UTF-8', 18:57:05 INFO - 'LANGUAGE': 'en_US:en', 18:57:05 INFO - 'LOGNAME': 'cltbld', 18:57:05 INFO - 'MAIL': '/var/mail/cltbld', 18:57:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:57:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:57:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:05 INFO - 'MOZ_NO_REMOTE': '1', 18:57:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:57:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:05 INFO - 'NO_EM_RESTART': '1', 18:57:05 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:57:05 INFO - 'PWD': '/builds/slave/test-pgo', 18:57:05 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:57:05 INFO - 'SHELL': '/bin/bash', 18:57:05 INFO - 'SHLVL': '1', 18:57:05 INFO - 'TERM': 'linux', 18:57:05 INFO - 'TMOUT': '86400', 18:57:05 INFO - 'USER': 'cltbld', 18:57:05 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1447815148.607166-20276609', 18:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:05 INFO - '_': '/tools/buildbot/bin/python'} 18:57:05 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost'] with output_timeout 3600 18:57:05 INFO - mozversion INFO | application_buildid: 20151117173015 18:57:05 INFO - mozversion INFO | application_changeset: 8e712e56faf8ef12537ad604f38bca4f06665a7b 18:57:05 INFO - mozversion INFO | application_display_name: Nightly 18:57:05 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:57:05 INFO - mozversion INFO | application_name: Firefox 18:57:05 INFO - mozversion INFO | application_remotingname: firefox 18:57:05 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 18:57:05 INFO - mozversion INFO | application_vendor: Mozilla 18:57:05 INFO - mozversion INFO | application_version: 45.0a1 18:57:05 INFO - mozversion INFO | platform_buildid: 20151117173015 18:57:05 INFO - mozversion INFO | platform_changeset: 8e712e56faf8ef12537ad604f38bca4f06665a7b 18:57:05 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 18:57:05 INFO - mozversion INFO | platform_version: 45.0a1 18:57:05 INFO - 2015-11-17 18:57:05,801 DEBUG : using testdate: 1447815425 18:57:05 INFO - 2015-11-17 18:57:05,801 DEBUG : actual date: 1447815425 18:57:05 INFO - 2015-11-17 18:57:05,810 INFO : starting webserver on 'localhost:43172' 18:57:05 INFO - 2015-11-17 18:57:05,810 INFO : Starting test suite talos-linux64-ix-026 18:57:05 INFO - 2015-11-17 18:57:05,811 INFO : Starting test dromaeo_css 18:57:05 INFO - 2015-11-17 18:57:05,811 DEBUG : operating with platform_type : linux_ 18:57:05 INFO - 2015-11-17 18:57:05,812 INFO : Initialising browser for dromaeo_css test... 18:57:05 INFO - 2015-11-17 18:57:05,824 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuUXt4h/profile http://localhost:43172/getInfo.html 18:57:09 INFO - 2015-11-17 18:57:09,896 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:57:09 INFO - 2015-11-17 18:57:09,896 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:57:09 INFO - 2015-11-17 18:57:09,896 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:57:09 INFO - 2015-11-17 18:57:09,896 DEBUG : BROWSER_OUTPUT: __metrics 18:57:10 INFO - 2015-11-17 18:57:10,054 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:57:11 INFO - 2015-11-17 18:57:11,293 INFO : Browser initialized. 18:57:11 INFO - 2015-11-17 18:57:11,293 INFO : Running cycle 1/1 for dromaeo_css test... 18:57:11 INFO - 2015-11-17 18:57:11,294 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuUXt4h/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:57:23 INFO - 2015-11-17 18:57:23,048 DEBUG : BROWSER_OUTPUT: RSS: Main: 141815808 18:57:23 INFO - 2015-11-17 18:57:23,048 DEBUG : BROWSER_OUTPUT: 18:58:14 INFO - 2015-11-17 18:58:14,539 DEBUG : BROWSER_OUTPUT: 1447815494538 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] 19:00:22 INFO - 2015-11-17 19:00:22,659 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43172/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43172/tests/dromaeo/cssquery-ext.html) 19:00:23 INFO - 2015-11-17 19:00:23,744 DEBUG : BROWSER_OUTPUT: RSS: Main: 218841088 19:00:23 INFO - 2015-11-17 19:00:23,744 DEBUG : BROWSER_OUTPUT: 19:03:26 INFO - 2015-11-17 19:03:26,132 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43172/tests/dromaeo/cssquery-ext.html (next: http://localhost:43172/tests/dromaeo/cssquery-jquery.html) 19:03:26 INFO - 2015-11-17 19:03:26,698 DEBUG : BROWSER_OUTPUT: RSS: Main: 221253632 19:03:26 INFO - 2015-11-17 19:03:26,698 DEBUG : BROWSER_OUTPUT: 19:06:28 INFO - 2015-11-17 19:06:28,588 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43172/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43172/tests/dromaeo/cssquery-mootools.html) 19:06:29 INFO - 2015-11-17 19:06:29,155 DEBUG : BROWSER_OUTPUT: RSS: Main: 210710528 19:06:29 INFO - 2015-11-17 19:06:29,155 DEBUG : BROWSER_OUTPUT: 19:09:30 INFO - 2015-11-17 19:09:30,958 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43172/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43172/tests/dromaeo/cssquery-prototype.html) 19:09:31 INFO - 2015-11-17 19:09:31,544 DEBUG : BROWSER_OUTPUT: RSS: Main: 202502144 19:09:31 INFO - 2015-11-17 19:09:31,544 DEBUG : BROWSER_OUTPUT: 19:12:33 INFO - 2015-11-17 19:12:33,916 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43172/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43172/tests/dromaeo/cssquery-yui.html) 19:12:34 INFO - 2015-11-17 19:12:34,482 DEBUG : BROWSER_OUTPUT: RSS: Main: 204304384 19:12:34 INFO - 2015-11-17 19:12:34,482 DEBUG : BROWSER_OUTPUT: 19:15:37 INFO - 2015-11-17 19:15:37,035 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43172/tests/dromaeo/cssquery-yui.html (next: http://localhost:43172/tests/dromaeo/cssquery-dojo.html) 19:15:37 INFO - 2015-11-17 19:15:37,281 DEBUG : BROWSER_OUTPUT: RSS: Main: 244862976 19:15:37 INFO - 2015-11-17 19:15:37,282 DEBUG : BROWSER_OUTPUT: 19:15:37 INFO - 2015-11-17 19:15:37,283 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:15:37 INFO - 2015-11-17 19:15:37,283 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:15:37 INFO - 2015-11-17 19:15:37,283 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:15:37 INFO - 2015-11-17 19:15:37,284 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:15:37 INFO - 2015-11-17 19:15:37,285 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3127.515235138553;3189.2186414328494;3225.290436104058;3225.3065590897954;3248.366568519139;5166.922496162551;5320.6275560710765;5328.200769884519;5363.168708850129;5382.327209098858;5195.480451954802;5282.498162674549;5333.173358129487;5361.544268737162;5377.731113444322;4901.387326584186;4949.950500495003;4957.5042495750495;4982.501749825006;5005.774740136702;5005.474425185358;5019.322391477141;5061.797528098871;5064.721440320781;5073.239014147871;4661.510541393139;4809.759512024402;4847.903041939141;4865.270209468608;4906.141425250603;4918.163912134945;4938.160512712848;4945.67853089548;4957.5042495750495;4995.975020124913;4904.6076313895155;4940.555350018516;4941.654084214107;4963.354763880709;5001.099802035632;5148.124818780779;5152.510511501401;5258.290130832365;5277.70972596507;5285.577153827685;5731.197632331477;5863;5874.823755287348;5877.970610146965;5891.970540147272;5870.853228669274;5883.23517942669;5900.43945825146;5902.498287645555;5909.734061967179;5292.391374991887;5297.973510132425;5387.46125387466;5395.29861118056;5424.783008679648;5951.256092988377;5981.282246130492;6000.519958403317;6043.667598282049;6046.09308603713;5532.612717109763;5805.8548536286935;5809.302883653989;5817.214676018683;5818.44724751148;5768.913466298009;5773.826785196451;5880.176775251468;5890.410958904161;5920.141579471038;5740.339860915965;5744.885102298014;5746.02317606008;5746.655200687972;5753.712314384264;5525.309336332958;5632.436756324417;5723.570732195102;5726.255586773693;5731;4369.126174764996;4421.46942366918;4424.048829501673;4428.977855110704;4454.242778727624;3949.249642567903;3950.881473555798;3980.124372638015;3995.2409042281874;3998.28030954431;5247.685138891678;5346;5410.513053825174;5413.431589683105;5448.673079615236;5677.063284558001;5780.364159942403;5795.333536643256;5804.593678442468;5842.211301474246;5473.0969390051;5478.58910581708;5485.4788795064405;5487.5884308677005;5503.2020357048;4926.630502712311;4965.602751779849;5029.06962211992;5072.51811077947;5073;5998.490128339053;6102.786402475981;6103.267607886994;6106.145139680449;6107.786227482017;5913.172155898092;5925.377835327228;5926.792562260473;5930.495907847881;5934.6142500737315;5739.770409183586;5788.942110578841;5893.6463812171405;5905.645661260338;6063.029915213545;5803.709814509173;5819.5344372450945;5832.12518122285;5833.82498525045;5837.970810146092;5883.382244864399;5884.411558844253;5884.588078834612;5887.322957859729;5896.204012458435;5361.303030605996;5468.207109968953;5505.9724701376235;5665.405132461032;5740.540756739534;5647.661140331593;5650.406707295675;5655;5663.830085097454;5755.683437410982;5563.332400112013;5565.471280228372;5566.832995010156;5573.191887176417;5581.358143813351;5499.945000550103;5521.309836270466;5577.247071645438;5629.662220266797;5664.26364572603;5519.862003449785;5578.609497335147;5579.553635709215;5620.494155526022;5624.240727501735 19:15:37 INFO - 2015-11-17 19:15:37,286 DEBUG : BROWSER_OUTPUT: |1;ext.html;561.0178194473498;578.401354597991;579.2383016333521;586.437020460358;593.7031484257872;30842.845785771067;31644.36711265776;31682.841585792037;40452.19095618086;40902;41970.58029419705;42345;42405;42442.36336454956;42510;8761.912380876205;8943.10568943107;8948.328875334344;8958.417702849327;8959.104089591054;7886.369090472748;8070.192980701912;8639.136086391341;10384.221183411237;10562.155027597812;10419;10521.316114452575;10559.313644613114;10566.471676416188;10577;7874.52752834826;10428.947855260712;10523.84214236787;10534.262601617851;10538.789224215472;7741.458097933147;9927.652532161339;10135.341202821866;10140.087392134743;10148.89851101487;33818.830905845556;34126.65873341284;34132.31735365304;34146;34163;3240.9351812963846;3295.0609076413107;3509.491123787062;3709.888703338904;3916.0797212655;26939.461210775673;27107.322316942038;27482.17553473399;27616.861915690493;27806.3048423789;3410.693037626601;3487.930241395183;3494.72042236623;3515.384807658675;3603.0992251937014;274614;274929;275077;275693;275728.6213568939;56018;56272.71863640656;56281.43718562762;56286;56520;57217.427825721206;57333.14000289999;57356.71321643365;57714.42285577091;57767;14202.85797142036;14406.351714172888;14512.346944387527;14555.490557830637;14561.78157327641;10922.945385273182;10936;11011;11014.944925275322;11017.559297628166;18028.639427211383;18205.27178912855;18589.535261618297;18655.720164197548;18663.16015779266;7260.165081015751;7338.963305183546;7417.443691723034;7434.145073316529;7539.886901696479;919.6551293265026;952.5332587032304;970.7136394763562;973.9269554783419;1046.1682962045193;25929.870350648125;26222.868885655833;26283.737162628127;26330;26430.07494737675;908.0238743350924;913.6025828764376;1004.2267454060478;1020.3775696824931;1093.2456604942565;12299;13595.45618175262;13654.522091726742;13815.654608634864;13908.235047072509;318367;321764;321900;322778;323004;48302.5169748298;48540.27189592159;48844.511554884;48857.755711221216;48931.755341223776;1163.1857699610136;1206.831043653889;1228.0973484488893;1260.9369531523387;1321.914075585084;25101;26361.736382636696;26483.337916552242;26629.60055599129;26650.733492664825;39275.803620981715;39467.2106557873;39701.404478933415;39775;41895.7905210472;254970;306593;318631;318953;321436;27424.588631170947;27685.30786730348;27896.30259243454;27935.720642794124;27961;39778.56664101436;40984.38523422211;41554.168916620896;41557;41562.792186038874;34246.657533424346;34434.13914652054;34819.82590087033;34891;35325.470117947734;33175.66824331726;33562;33636;33688.831555842065;34022;33048.33903321968;33075.83462082674;33161.336773263916;35072.9478115657;35493;28975.85512072426;29881.252968675955;30551.54172687367;30582;32370.838145810063;23568.88215558911;23853;24499.265022049367;25481.980720771702;26903.596446052932 19:15:37 INFO - 2015-11-17 19:15:37,286 DEBUG : BROWSER_OUTPUT: |2;jquery.html;350.18972743731536;351.3026642115402;355.8149762123695;357.5209219645675;362.85485805677723;14440.133591984488;14691.412343506274;16668.249928753205;16702.83297167028;17393.913030434847;16244.918775406106;17022.82977170228;17259.74110388345;17316.567085822862;17403.303867845272;5289.814856480014;5441.129419292914;5441.401445840955;5442.455754424565;5445.401005889369;3843.961560384402;3929.7052721045893;5362.490563396471;5407.5133238008575;5772.163036359725;5929.555283353744;5965.582409231356;5982.940170598304;5984.102384642317;6002.96998515009;5771.192033115367;5846.795362162304;5850.3564607893095;5856.590038697293;5858.443447872467;5174.2238664200295;5190;5192.169252919514;5195.064888320101;5206.062908676437;19767;21200;21680.34958951234;21825.23611673584;21853;2104.705341252226;2107.104480595756;2217.46780772615;2256.458449971995;2310.330004298751;12919.67700807478;13039.934800326033;13057.151285166528;13345.33273336339;13632.863671363259;1771.4685594321782;1795.066565386005;1848.7781466224005;1857.4984754116313;1873;57853;59051.40948590545;60158.69920650413;60586.335503094626;61267;9962;10172.949135254275;10233.181345492343;10244.385336879663;10255.692329229985;13093.279869607073;13154.144980576231;13179.14335568185;13193.93403032998;13223.404946777418;7016.719331226694;7033.929660703429;7181.856362872713;7231.638418079075;7235.963820180866;6508.934910650928;6516.283208847023;6527.673616319165;6562.310957349505;6571.080048793173;6092.837042849813;6124.5100391968535;6162.322144564095;6166.1983942087245;6212.844678882973;1668.4077152610892;1726.3772054268948;1740.7562941188244;1742.9302827886743;1752.8597712182996;867.4621734524509;878.4816957994686;922.2437601167113;934.2152591822901;1032.8170907823285;16372.83627163713;17097.974121552747;17902.731459028124;18057.09714514269;18070.3675371364;933.1228645073609;963.8145081549733;986.4377304936118;988.4958671077802;997.6558087459815;6077.483413909778;6454.935450645434;6577.671116444254;6585.440237579764;10163.542640581192;530801;533924;541326;543769;545642;41503.58496414997;45934.31098533524;45981;72387.63806180935;77542;521.7782442461938;535.7267793425381;537.2022546518417;537.4437457231746;538.8168022872243;11020.228583999044;11196.776064478829;11222.494987725735;11346.432678365883;11423.314601123959;36863.26273474462;37084;37810.81094594619;38089.42865856959;38331.616683832806;49125.508744913524;49689;50017;51158.48841511686;51701.22448163356;6540.37866402691;6833.726650933907;6841.452683785185;6843.486738494533;6850.417714494324;11976.880231197576;12164.148509604243;12185.14703970749;12406.441710122886;12422.813657794959;7613.771586852404;8757.91242087571;10664.89335106639;10752.784944301227;10837.241393102722;10077.244206684381;10298.330608510423;10482.266241363031;10534.262601617813;10582.947085264525;10640.308379955279;10688.73278168021;10754.354738715701;10917.072048875934;10969.890301096886;6748.527603067738;6793.354631310018;6814.829629259309;6815.352541508549;6816.659167041529;10403.271770975958;10644;10669.57321707123;10689.251752377259;11055.391953442639 19:15:37 INFO - 2015-11-17 19:15:37,288 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1276.3107921722271;1364.7748121559944;1395.1629022586449;1460.123925644613;1514.1445083527806;6665.133532640756;7352.448566357524;7584.241575842413;7592.354649854762;7597.088349398066;7517.210692877251;7617.695292188319;7630.084389873223;7645;7653.464257501977;2227.5544891021777;2244.528648983707;2246.6854640350366;2249.302716157988;2250.0437314141504;2232.8660280383147;2243.7083179186766;2311.4914718761847;2313.0747700919683;2313.363824948136;2211.7124773779387;2240.271911628719;2240.801171373316;2242.4281808138985;2244.663300504921;2232.8213742900693;2259.186692790602;2260.2315212827634;2267.0931627349028;2267.7051983242236;2218.0794970087395;2226.8441209115367;2229.030371788277;2231.0518029837417;2231.8884055797143;6526.412622863965;6659.467242620579;7547.207543207939;7575.053118360205;7586.58273794941;4127.6904232182405;4494.550544945512;4576.519465456146;4579.519150489184;4612.331211974279;2928.633920759905;2978.80637758545;3019.3659331540402;3021.5165573508134;3060.342026464321;956.2541217850019;966.6375109334;974.9853752193723;987.9703608891673;995.2038369304528;10041.949790251076;10063;10068;10070.848937265946;10071.194304455626;4099.487564054493;4102.671786257092;4146.937795933063;4221.936670949938;4229.598188172119;8807.91192088071;8824.691135810344;8825.07336729647;8827.205551500396;8848.601812918434;4589.059242855206;4594.33382159585;4623.791929363187;4625.213713668684;4631.745254010994;4224.324108142682;4228.1966426378885;4228.6617070634275;4230.471191101113;4232.3016702243785;3555.2711694102645;3620.3845346291196;3642.562892452923;3652.141746689526;3665.7617254878346;1169.7601991591703;1177.670252329349;1186.1044911092242;1196.1447564991074;1198.8801119887942;1094.042712626452;1108.645233525264;1110.4891749795186;1116.4417791104447;1156.2657712352548;7124.715011399486;7126.180489243699;7143.82140446493;7154.4991850571005;7158.856822863513;501.7315736081179;502.09873277467034;507.2999261019769;511.50384127396364;511.8298414721628;5303.416624171338;5691.260136182353;5743.6789538405565;5744.482996530249;5755;8064.717734879251;8888.466691998501;9194.356395052417;9196.816063678689;9200.861987070199;8735.91264087351;8947.642094316154;8978.775530611787;9006.63973441055;9051;6917.927721203221;7029.507934444539;7058.258882817333;7067.505274630829;7075.2570980047385;6958.826029349307;7016.6842492089;7055.964720176366;7063.682134304071;7121.572705637678;8051.597420129087;8085.5957202140835;8112.472689275178;8200.42597018203;8225.465344752572;8268.875966860382;8311.459755115899;8452.408331416987;8453.027901791373;8465.619047143016;6910.343517365842;6978.79063628092;6990.580565166107;6991.405730512964;6997.47518936092;7076.115485564304;7520.774376768706;7526.360259378014;7555.73554925597;7556.8488630228185;6584.407403333531;6993.125859267591;7055.118110236221;7149.356557909813;7181.281871812777;6819.181698196248;6881.311868813279;6908.412784913137;7046;7074.257202993817;6873.48448866347;6896;6932.410745086522;6937.895931561132;6959.095317608679;6319.336469670802;6421.261554921057;6437.420632143129;6443.67781610927;6447.838804029937;6389.233292004989;6392.808215753535;6445.2587952386075;6446.64543450096;6454.290028097 19:15:37 INFO - 2015-11-17 19:15:37,289 DEBUG : BROWSER_OUTPUT: |4;prototype.html;328.4793602140607;332.36352385182374;337.1756056442;342.43498227923936;342.7155460967397;5958.493528050116;6003.309619393771;6049.334573196945;6089.482393996515;6090.299615544213;5668.688222147791;5823.272090988627;5825.475707186352;5938.554608404365;5955.166276721252;4606.97696511517;4631.258998560231;4647.047355292166;4664.277037059262;4665.510121437251;4614.584687378136;4637.8840528986875;4651.3720647712635;4651.651126165534;4653.837115700934;4370.868873933787;4453.6437085033285;4466.263066594008;4578.542145785428;4583.908321833561;4574.88562785933;4581.221192397301;4584.7936842842155;4592.448906131252;4594;4019.8995025124314;4032.899177520556;4039.9596004039877;4042.514898212204;4050.594940505926;5693.060644993571;5711.114777209497;5711.543076553866;5714.857128571777;5725.599208055438;5160.8967820643375;5307.310049693515;5311.389190243094;5315.069862774038;5316.627836051478;6320.336364681734;6324.241091069055;6330.113784070234;6332.905006424908;6340.239171299428;4390.868273951786;4395.296752519582;4396.274614688573;4403.0533435311245;4409.470863496401;6480.930646443331;6556.213254409454;6579.93420065798;6588.209414870151;6633.867322653568;4480.731156130642;4483.461984561808;4483.686141970031;4485.237509623372;4491.955080449219;4538.228501154812;4539.16025535277;4541.568550987651;4541.886452838706;4545.545445455428;5276.419593844674;5278.524932755993;5282.260483532308;5282.524572788468;5285.2600635911;6289.088082228142;6411.487081033506;6418.358164183638;6424.518161137933;6426.710798014101;1589.7535881938318;1607.4213283218032;1609.501054673055;1610.9838901610833;1611.427943080213;1046.3826342457987;1060.5015642647943;1069.2515239332342;1073.9087177589993;1075.6127793994156;6175.505959523227;6181.227346581677;6183.288921774054;6185.381461853779;6194.628322300677;6588.8023359299295;6591.769288074895;6599.340065993459;6610.338966103352;6614.404703576702;5959.612625179436;6049.153118563405;6051.818445446644;6170.753169873155;6180.938190618126;3543.9822800886345;3595.0832537702718;3596.17288023756;3599.3161299353037;3606.04439823447;6870.484713646497;6879.277675843964;6880.380765731108;6881.965590172017;6883.242843287235;6692.397684208445;6865.592553526515;6870.587764734132;6880.58716477003;6880.827979300558;6871.793846184622;6874.2094659113845;6875.449964002868;6879.58722476653;6893.965530172317;6551.377619126175;6682.264950855305;6682.532222744361;6684.532082754161;6687.665616719242;6544.411003009752;6584.901226481511;6600.80197594073;6601.603903765789;6602.471802255904;6859.657017149222;6862.622555759481;6863.691133899087;6868.381845633917;6870.866307059479;4462.620677242471;4472.530384309731;4474.3959565459545;4478.880279930017;4482.529334419839;6514.478841692748;6657.467402607683;6662.433693135944;6669.799906002828;6682.665866706548;6477.77327793525;6479.7408103675325;6486.481081513562;6492.318306577741;6505.674716264073;6370.044493326038;6443.323451037573;6470.320616335405;6481.222253329631;6482.902756458751;6341.841453963688;6354.809355719336;6362.586431881913;6370.331115232834;6371.553991220755;6509.7396104155305;6515.478761699147;6516.706748196248;6517.478601711757;6521.413072823469;6208.192934918432;6338.778142764981;6349.714262858275;6360.300366959723;6363.5227357947415 19:15:37 INFO - 2015-11-17 19:15:37,289 DEBUG : BROWSER_OUTPUT: |5;yui.html;669.7354544954743;684.1038239905724;685.6057766784099;695.2387136085987;718.2924819053235;13228.14017088891;13241.470341186365;13293.7341253175;13340;13341.53304634338;13022.674433139176;13191.538296159611;13231.338433078332;13237.801432978513;13264.071514993955;678.0304165043985;683.6615875141812;708.6208878250137;716.451914285572;807.7415227127336;815.3925325632412;815.559597817178;821.4085858182129;822.5887056471764;822.7408366364606;702.5257950883159;850.0267194062794;851.8424091543053;854.3080105114877;854.5470900422786;703.3704834173411;842.1578421578422;853.6542700206395;859.9140085991413;860.4450129666393;624.1293395712955;630.5176539946945;630.8328293002359;630.9432151106377;631.4127861089186;12221.327826969513;12243.142979991404;12267.447964841514;12295.262284262973;12312.076594255466;11945.581904633384;12016.158868879182;12393.132480726354;12439.191452555555;12663.11358204926;10214.744631384201;10259.69220923366;10270.794584108276;10477.37135771856;10509.211809114347;3554.662307080823;3582.6417358263966;3602.2615363850346;3617.3307938031285;3732.029672285198;46521.06957860858;46587.30119048217;46628.3005754914;46682.76658616719;46767.29849052267;9047.411918225425;9115.134062264075;9192.402493837879;9232.307576931757;9461.290403219786;17045.31818727237;17055.829441705424;17083.40208092711;17088;17097.401590944257;7129.572225666477;7212.71149154028;7289.890651640229;7352.301531354619;7394.149672787591;4271.700980931367;4338.414314067623;4394.934075988863;4493.370928070073;4496.685232033792;2706.553418685934;2753.6833264174475;2771.196353057631;2772.5841123831588;2773.2234974207254;440.8985933235374;453.6393567114152;456.74878816651375;463.03688328277104;464.21315869601375;606.3300053440972;621.2638023941553;630.782380078872;634.9492040636738;638.409471239102;8210.794730131794;8983.865242021375;9143.13140251675;9265.814683706289;9489.288303377274;491.4397586751107;660.5805313625882;679.58205703492;680.2245440198178;705.2383425900016;4040.6363427291685;4092.345224764083;4220.345846393814;4228.3234682451275;4242.830286788556;61708.38291617116;62110.689446553384;62149;62200.68899655563;62214;52223.216651750256;53698;53701;53717;53766.46233537693;48594.514054859705;49211;49575;49597.75201123971;49834.25248621274;7922.366210703015;7994.680212791423;8045.155258697752;8057.355411567178;8254.793630159054;34008.489872652426;34928.82535587306;35736.106597335274;35970.28059438849;36064.27871442504;45056.324155137045;46223;46473.76763116163;46827.53172468232;47690.28464573104;7787.688492460465;7919.445638805459;8285.212904774036;8290.46112002718;8369.83260334802;12095.75808483843;12231.266124032587;12234.20155842101;12340.136190466581;13016.15394999322;10417.322874013165;10519.631812886511;10657.520411581343;10908.072813810915;10916.727081823017;10603.522841472306;10939.56241750321;11022;11325.433728313716;11706.697619968834;7462.514936529108;10198.286119971532;10522.263441559018;10705.090067344363;10755.139588832719;9173.724788256362;9225.308101892251;9336.253099752139;9520.666776662783;9607.759806004906;8805.471671699463;9053.818923621622;9276.675316363895;9384.530773461436;9483.620655173716 19:15:37 INFO - 2015-11-17 19:15:37,289 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:15:37 INFO - 2015-11-17 19:15:37,289 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:15:37 INFO - 2015-11-17 19:15:37,290 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,846 19:15:37 INFO - 2015-11-17 19:15:37,290 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:15:37 INFO - 2015-11-17 19:15:37,290 DEBUG : BROWSER_OUTPUT: __startTimestamp1447816537282__endTimestamp 19:15:37 INFO - 2015-11-17 19:15:37,290 DEBUG : BROWSER_OUTPUT: 19:15:37 INFO - 2015-11-17 19:15:37,290 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:15:37 INFO - 2015-11-17 19:15:37,290 DEBUG : BROWSER_OUTPUT: Number of tests: 6 19:15:37 INFO - 2015-11-17 19:15:37,290 DEBUG : BROWSER_OUTPUT: 19:15:37 INFO - 2015-11-17 19:15:37,290 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5378.77 Median:5532.61 stddev:610.83 (11.0%) stddev-sans-first:586.62 19:15:37 INFO - 2015-11-17 19:15:37,291 DEBUG : BROWSER_OUTPUT: Values: 3127.5 3189.2 3225.3 3225.3 3248.4 5166.9 5320.6 5328.2 5363.2 5382.3 5195.5 5282.5 5333.2 5361.5 5377.7 4901.4 4950.0 4957.5 4982.5 5005.8 5005.5 5019.3 5061.8 5064.7 5073.2 4661.5 4809.8 4847.9 4865.3 4906.1 4918.2 4938.2 4945.7 4957.5 4996.0 4904.6 4940.6 4941.7 4963.4 5001.1 5148.1 5152.5 5258.3 5277.7 5285.6 5731.2 5863.0 5874.8 5878.0 5892.0 5870.9 5883.2 5900.4 5902.5 5909.7 5292.4 5298.0 5387.5 5395.3 5424.8 5951.3 5981.3 6000.5 6043.7 6046.1 5532.6 5805.9 5809.3 5817.2 5818.4 5768.9 5773.8 5880.2 5890.4 5920.1 5740.3 5744.9 5746.0 5746.7 5753.7 5525.3 5632.4 5723.6 5726.3 5731.0 4369.1 4421.5 4424.0 4429.0 4454.2 3949.2 3950.9 3980.1 3995.2 3998.3 5247.7 5346.0 5410.5 5413.4 5448.7 5677.1 5780.4 5795.3 5804.6 5842.2 5473.1 5478.6 5485.5 5487.6 5503.2 4926.6 4965.6 5029.1 5072.5 5073.0 5998.5 6102.8 6103.3 6106.1 6107.8 5913.2 5925.4 5926.8 5930.5 5934.6 5739.8 5788.9 5893.6 5905.6 6063.0 5803.7 5819.5 5832.1 5833.8 5838.0 5883.4 5884.4 5884.6 5887.3 5896.2 5361.3 5468.2 5506.0 5665.4 5740.5 5647.7 5650.4 5655.0 5663.8 5755.7 5563.3 5565.5 5566.8 5573.2 5581.4 5499.9 5521.3 5577.2 5629.7 5664.3 5519.9 5578.6 5579.6 5620.5 5624.2 19:15:37 INFO - 2015-11-17 19:15:37,291 DEBUG : BROWSER_OUTPUT: 19:15:37 INFO - 2015-11-17 19:15:37,291 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45693.22 Median:17805.89 stddev:78886.00 (443.0%) stddev-sans-first:79034.52 19:15:37 INFO - 2015-11-17 19:15:37,292 DEBUG : BROWSER_OUTPUT: Values: 561.0 578.4 579.2 586.4 593.7 30842.8 31644.4 31682.8 40452.2 40902.0 41970.6 42345.0 42405.0 42442.4 42510.0 8761.9 8943.1 8948.3 8958.4 8959.1 7886.4 8070.2 8639.1 10384.2 10562.2 10419.0 10521.3 10559.3 10566.5 10577.0 7874.5 10428.9 10523.8 10534.3 10538.8 7741.5 9927.7 10135.3 10140.1 10148.9 33818.8 34126.7 34132.3 34146.0 34163.0 3240.9 3295.1 3509.5 3709.9 3916.1 26939.5 27107.3 27482.2 27616.9 27806.3 3410.7 3487.9 3494.7 3515.4 3603.1 274614.0 274929.0 275077.0 275693.0 275728.6 56018.0 56272.7 56281.4 56286.0 56520.0 57217.4 57333.1 57356.7 57714.4 57767.0 14202.9 14406.4 14512.3 14555.5 14561.8 10922.9 10936.0 11011.0 11014.9 11017.6 18028.6 18205.3 18589.5 18655.7 18663.2 7260.2 7339.0 7417.4 7434.1 7539.9 919.7 952.5 970.7 973.9 1046.2 25929.9 26222.9 26283.7 26330.0 26430.1 908.0 913.6 1004.2 1020.4 1093.2 12299.0 13595.5 13654.5 13815.7 13908.2 318367.0 321764.0 321900.0 322778.0 323004.0 48302.5 48540.3 48844.5 48857.8 48931.8 1163.2 1206.8 1228.1 1260.9 1321.9 25101.0 26361.7 26483.3 26629.6 26650.7 39275.8 39467.2 39701.4 39775.0 41895.8 254970.0 306593.0 318631.0 318953.0 321436.0 27424.6 27685.3 27896.3 27935.7 27961.0 39778.6 40984.4 41554.2 41557.0 41562.8 34246.7 34434.1 34819.8 34891.0 35325.5 33175.7 33562.0 33636.0 33688.8 34022.0 33048.3 33075.8 33161.3 35072.9 35493.0 28975.9 29881.3 30551.5 30582.0 32370.8 23568.9 23853.0 24499.3 25482.0 26903.6 19:15:37 INFO - 2015-11-17 19:15:37,292 DEBUG : BROWSER_OUTPUT: 19:15:37 INFO - 2015-11-17 19:15:37,292 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27592.69 Median:22716.65 stddev:87982.14 (387.3%) stddev-sans-first:88205.17 19:15:37 INFO - 2015-11-17 19:15:37,293 DEBUG : BROWSER_OUTPUT: Values: 350.2 351.3 355.8 357.5 362.9 14440.1 14691.4 16668.2 16702.8 17393.9 16244.9 17022.8 17259.7 17316.6 17403.3 5289.8 5441.1 5441.4 5442.5 5445.4 3844.0 3929.7 5362.5 5407.5 5772.2 5929.6 5965.6 5982.9 5984.1 6003.0 5771.2 5846.8 5850.4 5856.6 5858.4 5174.2 5190.0 5192.2 5195.1 5206.1 19767.0 21200.0 21680.3 21825.2 21853.0 2104.7 2107.1 2217.5 2256.5 2310.3 12919.7 13039.9 13057.2 13345.3 13632.9 1771.5 1795.1 1848.8 1857.5 1873.0 57853.0 59051.4 60158.7 60586.3 61267.0 9962.0 10172.9 10233.2 10244.4 10255.7 13093.3 13154.1 13179.1 13193.9 13223.4 7016.7 7033.9 7181.9 7231.6 7236.0 6508.9 6516.3 6527.7 6562.3 6571.1 6092.8 6124.5 6162.3 6166.2 6212.8 1668.4 1726.4 1740.8 1742.9 1752.9 867.5 878.5 922.2 934.2 1032.8 16372.8 17098.0 17902.7 18057.1 18070.4 933.1 963.8 986.4 988.5 997.7 6077.5 6454.9 6577.7 6585.4 10163.5 530801.0 533924.0 541326.0 543769.0 545642.0 41503.6 45934.3 45981.0 72387.6 77542.0 521.8 535.7 537.2 537.4 538.8 11020.2 11196.8 11222.5 11346.4 11423.3 36863.3 37084.0 37810.8 38089.4 38331.6 49125.5 49689.0 50017.0 51158.5 51701.2 6540.4 6833.7 6841.5 6843.5 6850.4 11976.9 12164.1 12185.1 12406.4 12422.8 7613.8 8757.9 10664.9 10752.8 10837.2 10077.2 10298.3 10482.3 10534.3 10582.9 10640.3 10688.7 10754.4 10917.1 10969.9 6748.5 6793.4 6814.8 6815.4 6816.7 10403.3 10644.0 10669.6 10689.3 11055.4 19:15:37 INFO - 2015-11-17 19:15:37,293 DEBUG : BROWSER_OUTPUT: 19:15:37 INFO - 2015-11-17 19:15:37,293 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5303.98 Median:6444.47 stddev:2746.46 (42.6%) stddev-sans-first:2737.48 19:15:37 INFO - 2015-11-17 19:15:37,293 DEBUG : BROWSER_OUTPUT: Values: 1276.3 1364.8 1395.2 1460.1 1514.1 6665.1 7352.4 7584.2 7592.4 7597.1 7517.2 7617.7 7630.1 7645.0 7653.5 2227.6 2244.5 2246.7 2249.3 2250.0 2232.9 2243.7 2311.5 2313.1 2313.4 2211.7 2240.3 2240.8 2242.4 2244.7 2232.8 2259.2 2260.2 2267.1 2267.7 2218.1 2226.8 2229.0 2231.1 2231.9 6526.4 6659.5 7547.2 7575.1 7586.6 4127.7 4494.6 4576.5 4579.5 4612.3 2928.6 2978.8 3019.4 3021.5 3060.3 956.3 966.6 975.0 988.0 995.2 10041.9 10063.0 10068.0 10070.8 10071.2 4099.5 4102.7 4146.9 4221.9 4229.6 8807.9 8824.7 8825.1 8827.2 8848.6 4589.1 4594.3 4623.8 4625.2 4631.7 4224.3 4228.2 4228.7 4230.5 4232.3 3555.3 3620.4 3642.6 3652.1 3665.8 1169.8 1177.7 1186.1 1196.1 1198.9 1094.0 1108.6 1110.5 1116.4 1156.3 7124.7 7126.2 7143.8 7154.5 7158.9 501.7 502.1 507.3 511.5 511.8 5303.4 5691.3 5743.7 5744.5 5755.0 8064.7 8888.5 9194.4 9196.8 9200.9 8735.9 8947.6 8978.8 9006.6 9051.0 6917.9 7029.5 7058.3 7067.5 7075.3 6958.8 7016.7 7056.0 7063.7 7121.6 8051.6 8085.6 8112.5 8200.4 8225.5 8268.9 8311.5 8452.4 8453.0 8465.6 6910.3 6978.8 6990.6 6991.4 6997.5 7076.1 7520.8 7526.4 7555.7 7556.8 6584.4 6993.1 7055.1 7149.4 7181.3 6819.2 6881.3 6908.4 7046.0 7074.3 6873.5 6896.0 6932.4 6937.9 6959.1 6319.3 6421.3 6437.4 6443.7 6447.8 6389.2 6392.8 6445.3 6446.6 6454.3 19:15:37 INFO - 2015-11-17 19:15:37,293 DEBUG : BROWSER_OUTPUT: 19:15:37 INFO - 2015-11-17 19:15:37,293 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5352.46 Median:6070.65 stddev:1628.11 (26.8%) stddev-sans-first:1588.40 19:15:37 INFO - 2015-11-17 19:15:37,295 DEBUG : BROWSER_OUTPUT: Values: 328.5 332.4 337.2 342.4 342.7 5958.5 6003.3 6049.3 6089.5 6090.3 5668.7 5823.3 5825.5 5938.6 5955.2 4607.0 4631.3 4647.0 4664.3 4665.5 4614.6 4637.9 4651.4 4651.7 4653.8 4370.9 4453.6 4466.3 4578.5 4583.9 4574.9 4581.2 4584.8 4592.4 4594.0 4019.9 4032.9 4040.0 4042.5 4050.6 5693.1 5711.1 5711.5 5714.9 5725.6 5160.9 5307.3 5311.4 5315.1 5316.6 6320.3 6324.2 6330.1 6332.9 6340.2 4390.9 4395.3 4396.3 4403.1 4409.5 6480.9 6556.2 6579.9 6588.2 6633.9 4480.7 4483.5 4483.7 4485.2 4492.0 4538.2 4539.2 4541.6 4541.9 4545.5 5276.4 5278.5 5282.3 5282.5 5285.3 6289.1 6411.5 6418.4 6424.5 6426.7 1589.8 1607.4 1609.5 1611.0 1611.4 1046.4 1060.5 1069.3 1073.9 1075.6 6175.5 6181.2 6183.3 6185.4 6194.6 6588.8 6591.8 6599.3 6610.3 6614.4 5959.6 6049.2 6051.8 6170.8 6180.9 3544.0 3595.1 3596.2 3599.3 3606.0 6870.5 6879.3 6880.4 6882.0 6883.2 6692.4 6865.6 6870.6 6880.6 6880.8 6871.8 6874.2 6875.4 6879.6 6894.0 6551.4 6682.3 6682.5 6684.5 6687.7 6544.4 6584.9 6600.8 6601.6 6602.5 6859.7 6862.6 6863.7 6868.4 6870.9 4462.6 4472.5 4474.4 4478.9 4482.5 6514.5 6657.5 6662.4 6669.8 6682.7 6477.8 6479.7 6486.5 6492.3 6505.7 6370.0 6443.3 6470.3 6481.2 6482.9 6341.8 6354.8 6362.6 6370.3 6371.6 6509.7 6515.5 6516.7 6517.5 6521.4 6208.2 6338.8 6349.7 6360.3 6363.5 19:15:37 INFO - 2015-11-17 19:15:37,295 DEBUG : BROWSER_OUTPUT: 19:15:37 INFO - 2015-11-17 19:15:37,295 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13813.82 Median:24851.22 stddev:16701.07 (67.2%) stddev-sans-first:16718.76 19:15:37 INFO - 2015-11-17 19:15:37,295 DEBUG : BROWSER_OUTPUT: Values: 669.7 684.1 685.6 695.2 718.3 13228.1 13241.5 13293.7 13340.0 13341.5 13022.7 13191.5 13231.3 13237.8 13264.1 678.0 683.7 708.6 716.5 807.7 815.4 815.6 821.4 822.6 822.7 702.5 850.0 851.8 854.3 854.5 703.4 842.2 853.7 859.9 860.4 624.1 630.5 630.8 630.9 631.4 12221.3 12243.1 12267.4 12295.3 12312.1 11945.6 12016.2 12393.1 12439.2 12663.1 10214.7 10259.7 10270.8 10477.4 10509.2 3554.7 3582.6 3602.3 3617.3 3732.0 46521.1 46587.3 46628.3 46682.8 46767.3 9047.4 9115.1 9192.4 9232.3 9461.3 17045.3 17055.8 17083.4 17088.0 17097.4 7129.6 7212.7 7289.9 7352.3 7394.1 4271.7 4338.4 4394.9 4493.4 4496.7 2706.6 2753.7 2771.2 2772.6 2773.2 440.9 453.6 456.7 463.0 464.2 606.3 621.3 630.8 634.9 638.4 8210.8 8983.9 9143.1 9265.8 9489.3 491.4 660.6 679.6 680.2 705.2 4040.6 4092.3 4220.3 4228.3 4242.8 61708.4 62110.7 62149.0 62200.7 62214.0 52223.2 53698.0 53701.0 53717.0 53766.5 48594.5 49211.0 49575.0 49597.8 49834.3 7922.4 7994.7 8045.2 8057.4 8254.8 34008.5 34928.8 35736.1 35970.3 36064.3 45056.3 46223.0 46473.8 46827.5 47690.3 7787.7 7919.4 8285.2 8290.5 8369.8 12095.8 12231.3 12234.2 12340.1 13016.2 10417.3 10519.6 10657.5 10908.1 10916.7 10603.5 10939.6 11022.0 11325.4 11706.7 7462.5 10198.3 10522.3 10705.1 10755.1 9173.7 9225.3 9336.3 9520.7 9607.8 8805.5 9053.8 9276.7 9384.5 9483.6 19:15:37 INFO - 2015-11-17 19:15:37,295 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:15:37 INFO - 2015-11-17 19:15:37,295 DEBUG : BROWSER_OUTPUT: 19:15:38 INFO - 2015-11-17 19:15:38,001 INFO : Browser exited with error code: 0 19:15:38 INFO - 2015-11-17 19:15:38,022 INFO : Completed test dromaeo_css (00:18:32) 19:15:38 INFO - 2015-11-17 19:15:38,022 INFO : Starting test kraken 19:15:38 INFO - 2015-11-17 19:15:38,022 DEBUG : operating with platform_type : linux_ 19:15:38 INFO - 2015-11-17 19:15:38,023 INFO : Initialising browser for kraken test... 19:15:38 INFO - 2015-11-17 19:15:38,028 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDDZIQx/profile http://localhost:43172/getInfo.html 19:15:41 INFO - 2015-11-17 19:15:41,841 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:15:41 INFO - 2015-11-17 19:15:41,841 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:15:41 INFO - 2015-11-17 19:15:41,841 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:15:41 INFO - 2015-11-17 19:15:41,841 DEBUG : BROWSER_OUTPUT: __metrics 19:15:41 INFO - 2015-11-17 19:15:41,897 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:43 INFO - 2015-11-17 19:15:43,297 INFO : Browser initialized. 19:15:43 INFO - 2015-11-17 19:15:43,298 INFO : Running cycle 1/1 for kraken test... 19:15:43 INFO - 2015-11-17 19:15:43,298 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDDZIQx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:15:55 INFO - 2015-11-17 19:15:55,080 DEBUG : BROWSER_OUTPUT: RSS: Main: 141438976 19:15:55 INFO - 2015-11-17 19:15:55,080 DEBUG : BROWSER_OUTPUT: 19:15:57 INFO - 2015-11-17 19:15:57,515 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43172/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43172/tests/kraken/driver.html?testName=audio-beat-detection) 19:15:58 INFO - 2015-11-17 19:15:58,096 DEBUG : BROWSER_OUTPUT: RSS: Main: 180310016 19:15:58 INFO - 2015-11-17 19:15:58,096 DEBUG : BROWSER_OUTPUT: 19:16:00 INFO - 2015-11-17 19:16:00,677 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43172/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43172/tests/kraken/driver.html?testName=audio-dft) 19:16:01 INFO - 2015-11-17 19:16:01,243 DEBUG : BROWSER_OUTPUT: RSS: Main: 169365504 19:16:01 INFO - 2015-11-17 19:16:01,243 DEBUG : BROWSER_OUTPUT: 19:16:04 INFO - 2015-11-17 19:16:04,090 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43172/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43172/tests/kraken/driver.html?testName=audio-fft) 19:16:04 INFO - 2015-11-17 19:16:04,651 DEBUG : BROWSER_OUTPUT: RSS: Main: 149303296 19:16:04 INFO - 2015-11-17 19:16:04,651 DEBUG : BROWSER_OUTPUT: 19:16:06 INFO - 2015-11-17 19:16:06,608 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43172/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43172/tests/kraken/driver.html?testName=audio-oscillator) 19:16:07 INFO - 2015-11-17 19:16:07,190 DEBUG : BROWSER_OUTPUT: RSS: Main: 152203264 19:16:07 INFO - 2015-11-17 19:16:07,190 DEBUG : BROWSER_OUTPUT: 19:16:09 INFO - 2015-11-17 19:16:09,343 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43172/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43172/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:16:09 INFO - 2015-11-17 19:16:09,909 DEBUG : BROWSER_OUTPUT: RSS: Main: 153763840 19:16:09 INFO - 2015-11-17 19:16:09,909 DEBUG : BROWSER_OUTPUT: 19:16:12 INFO - 2015-11-17 19:16:12,812 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43172/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43172/tests/kraken/driver.html?testName=imaging-darkroom) 19:16:13 INFO - 2015-11-17 19:16:13,386 DEBUG : BROWSER_OUTPUT: RSS: Main: 155062272 19:16:13 INFO - 2015-11-17 19:16:13,386 DEBUG : BROWSER_OUTPUT: 19:16:16 INFO - 2015-11-17 19:16:16,792 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43172/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43172/tests/kraken/driver.html?testName=imaging-desaturate) 19:16:17 INFO - 2015-11-17 19:16:17,366 DEBUG : BROWSER_OUTPUT: RSS: Main: 156545024 19:16:17 INFO - 2015-11-17 19:16:17,366 DEBUG : BROWSER_OUTPUT: 19:16:20 INFO - 2015-11-17 19:16:20,088 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43172/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43172/tests/kraken/driver.html?testName=json-parse-financial) 19:16:20 INFO - 2015-11-17 19:16:20,662 DEBUG : BROWSER_OUTPUT: RSS: Main: 155262976 19:16:20 INFO - 2015-11-17 19:16:20,662 DEBUG : BROWSER_OUTPUT: 19:16:22 INFO - 2015-11-17 19:16:22,230 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43172/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43172/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:16:22 INFO - 2015-11-17 19:16:22,791 DEBUG : BROWSER_OUTPUT: RSS: Main: 165904384 19:16:22 INFO - 2015-11-17 19:16:22,791 DEBUG : BROWSER_OUTPUT: 19:16:24 INFO - 2015-11-17 19:16:24,610 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43172/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43172/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:16:25 INFO - 2015-11-17 19:16:25,203 DEBUG : BROWSER_OUTPUT: RSS: Main: 164864000 19:16:25 INFO - 2015-11-17 19:16:25,204 DEBUG : BROWSER_OUTPUT: 19:16:27 INFO - 2015-11-17 19:16:27,260 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43172/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43172/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:16:27 INFO - 2015-11-17 19:16:27,832 DEBUG : BROWSER_OUTPUT: RSS: Main: 168480768 19:16:27 INFO - 2015-11-17 19:16:27,833 DEBUG : BROWSER_OUTPUT: 19:16:30 INFO - 2015-11-17 19:16:30,288 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43172/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43172/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:16:30 INFO - 2015-11-17 19:16:30,869 DEBUG : BROWSER_OUTPUT: RSS: Main: 178728960 19:16:30 INFO - 2015-11-17 19:16:30,869 DEBUG : BROWSER_OUTPUT: 19:16:33 INFO - 2015-11-17 19:16:33,430 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43172/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43172/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:16:33 INFO - 2015-11-17 19:16:33,997 DEBUG : BROWSER_OUTPUT: RSS: Main: 176492544 19:16:33 INFO - 2015-11-17 19:16:33,997 DEBUG : BROWSER_OUTPUT: 19:16:35 INFO - 2015-11-17 19:16:35,638 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43172/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43172/tests/kraken/driver.html?testName=ai-astar) 19:16:35 INFO - 2015-11-17 19:16:35,888 DEBUG : BROWSER_OUTPUT: RSS: Main: 237158400 19:16:35 INFO - 2015-11-17 19:16:35,888 DEBUG : BROWSER_OUTPUT: 19:16:35 INFO - 2015-11-17 19:16:35,889 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:16:35 INFO - 2015-11-17 19:16:35,889 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:16:35 INFO - 2015-11-17 19:16:35,889 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:16:35 INFO - 2015-11-17 19:16:35,890 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:16:35 INFO - 2015-11-17 19:16:35,890 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;110;103;109;108;109;99;111;109;104 19:16:35 INFO - 2015-11-17 19:16:35,890 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;123;150;164;127;146;159;125;169;129 19:16:35 INFO - 2015-11-17 19:16:35,890 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;162;162;161;161;159;164;161;161 19:16:35 INFO - 2015-11-17 19:16:35,891 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;82;93;72;73;72;104;93;74 19:16:35 INFO - 2015-11-17 19:16:35,891 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;90;134;90;90;90;145;90;90;133 19:16:35 INFO - 2015-11-17 19:16:35,891 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;110;109;108;108;108;109;109 19:16:35 INFO - 2015-11-17 19:16:35,891 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;146;146;146;145;146;145;146;147 19:16:35 INFO - 2015-11-17 19:16:35,891 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;96;96;96;96;96 19:16:35 INFO - 2015-11-17 19:16:35,891 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;58;58;57;58;57;58;67;55;56 19:16:35 INFO - 2015-11-17 19:16:35,891 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;69;69;69;70;70;69;70;70;70 19:16:35 INFO - 2015-11-17 19:16:35,891 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;83;85;83;84;84;85;84;84;86 19:16:35 INFO - 2015-11-17 19:16:35,892 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;121;126;117;114;130;126;124;136;122 19:16:35 INFO - 2015-11-17 19:16:35,892 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;146;148;154;145;139;155;150;157;141 19:16:35 INFO - 2015-11-17 19:16:35,892 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;65;65;65;66;65;65;66;65;66 19:16:35 INFO - 2015-11-17 19:16:35,892 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:16:35 INFO - 2015-11-17 19:16:35,892 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:16:35 INFO - 2015-11-17 19:16:35,892 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,913 19:16:35 INFO - 2015-11-17 19:16:35,892 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:16:35 INFO - 2015-11-17 19:16:35,893 DEBUG : BROWSER_OUTPUT: __startTimestamp1447816595888__endTimestamp 19:16:35 INFO - 2015-11-17 19:16:35,893 DEBUG : BROWSER_OUTPUT: 19:16:35 INFO - 2015-11-17 19:16:35,894 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:16:35 INFO - 2015-11-17 19:16:35,894 DEBUG : BROWSER_OUTPUT: Number of tests: 14 19:16:35 INFO - 2015-11-17 19:16:35,894 DEBUG : BROWSER_OUTPUT: 19:16:35 INFO - 2015-11-17 19:16:35,894 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.00 Median:109.00 stddev:3.77 (3.5%) stddev-sans-first:3.98 19:16:35 INFO - 2015-11-17 19:16:35,894 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 103.0 109.0 108.0 109.0 99.0 111.0 109.0 104.0 19:16:35 INFO - 2015-11-17 19:16:35,895 DEBUG : BROWSER_OUTPUT: 19:16:35 INFO - 2015-11-17 19:16:35,895 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.70 Median:152.50 stddev:17.39 (11.4%) stddev-sans-first:18.04 19:16:35 INFO - 2015-11-17 19:16:35,895 DEBUG : BROWSER_OUTPUT: Values: 155.0 123.0 150.0 164.0 127.0 146.0 159.0 125.0 169.0 129.0 19:16:35 INFO - 2015-11-17 19:16:35,895 DEBUG : BROWSER_OUTPUT: 19:16:35 INFO - 2015-11-17 19:16:35,895 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.26 (0.8%) stddev-sans-first:1.32 19:16:35 INFO - 2015-11-17 19:16:35,895 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 162.0 162.0 161.0 161.0 159.0 164.0 161.0 161.0 19:16:35 INFO - 2015-11-17 19:16:35,895 DEBUG : BROWSER_OUTPUT: 19:16:35 INFO - 2015-11-17 19:16:35,895 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.90 Median:73.50 stddev:11.65 (15.8%) stddev-sans-first:12.00 19:16:35 INFO - 2015-11-17 19:16:35,895 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 82.0 93.0 72.0 73.0 72.0 104.0 93.0 74.0 19:16:35 INFO - 2015-11-17 19:16:35,895 DEBUG : BROWSER_OUTPUT: 19:16:35 INFO - 2015-11-17 19:16:35,896 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.20 Median:90.00 stddev:23.08 (25.6%) stddev-sans-first:23.90 19:16:35 INFO - 2015-11-17 19:16:35,896 DEBUG : BROWSER_OUTPUT: Values: 90.0 90.0 134.0 90.0 90.0 90.0 145.0 90.0 90.0 133.0 19:16:35 INFO - 2015-11-17 19:16:35,896 DEBUG : BROWSER_OUTPUT: 19:16:35 INFO - 2015-11-17 19:16:35,897 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:108.90 Median:109.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 19:16:35 INFO - 2015-11-17 19:16:35,897 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 110.0 109.0 108.0 108.0 108.0 109.0 109.0 19:16:35 INFO - 2015-11-17 19:16:35,897 DEBUG : BROWSER_OUTPUT: 19:16:35 INFO - 2015-11-17 19:16:35,898 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 19:16:35 INFO - 2015-11-17 19:16:35,898 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 147.0 19:16:35 INFO - 2015-11-17 19:16:35,898 DEBUG : BROWSER_OUTPUT: 19:16:35 INFO - 2015-11-17 19:16:35,898 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 19:16:35 INFO - 2015-11-17 19:16:35,898 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 19:16:35 INFO - 2015-11-17 19:16:35,899 DEBUG : BROWSER_OUTPUT: 19:16:35 INFO - 2015-11-17 19:16:35,899 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.20 Median:58.00 stddev:3.26 (5.6%) stddev-sans-first:3.46 19:16:35 INFO - 2015-11-17 19:16:35,899 DEBUG : BROWSER_OUTPUT: Values: 58.0 58.0 58.0 57.0 58.0 57.0 58.0 67.0 55.0 56.0 19:16:35 INFO - 2015-11-17 19:16:35,899 DEBUG : BROWSER_OUTPUT: 19:16:35 INFO - 2015-11-17 19:16:35,899 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.00 stddev:0.52 (0.7%) stddev-sans-first:0.53 19:16:35 INFO - 2015-11-17 19:16:35,899 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 69.0 69.0 70.0 70.0 69.0 70.0 70.0 70.0 19:16:35 INFO - 2015-11-17 19:16:35,899 DEBUG : BROWSER_OUTPUT: 19:16:35 INFO - 2015-11-17 19:16:35,899 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:84.50 stddev:0.95 (1.1%) stddev-sans-first:0.97 19:16:35 INFO - 2015-11-17 19:16:35,899 DEBUG : BROWSER_OUTPUT: Values: 85.0 83.0 85.0 83.0 84.0 84.0 85.0 84.0 84.0 86.0 19:16:35 INFO - 2015-11-17 19:16:35,899 DEBUG : BROWSER_OUTPUT: 19:16:35 INFO - 2015-11-17 19:16:35,899 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:126.00 stddev:6.27 (5.0%) stddev-sans-first:6.61 19:16:35 INFO - 2015-11-17 19:16:35,899 DEBUG : BROWSER_OUTPUT: Values: 126.0 121.0 126.0 117.0 114.0 130.0 126.0 124.0 136.0 122.0 19:16:35 INFO - 2015-11-17 19:16:35,899 DEBUG : BROWSER_OUTPUT: 19:16:35 INFO - 2015-11-17 19:16:35,899 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.30 Median:149.00 stddev:6.73 (4.5%) stddev-sans-first:6.24 19:16:35 INFO - 2015-11-17 19:16:35,899 DEBUG : BROWSER_OUTPUT: Values: 138.0 146.0 148.0 154.0 145.0 139.0 155.0 150.0 157.0 141.0 19:16:35 INFO - 2015-11-17 19:16:35,900 DEBUG : BROWSER_OUTPUT: 19:16:35 INFO - 2015-11-17 19:16:35,900 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 19:16:35 INFO - 2015-11-17 19:16:35,900 DEBUG : BROWSER_OUTPUT: Values: 66.0 65.0 65.0 65.0 66.0 65.0 65.0 66.0 65.0 66.0 19:16:35 INFO - 2015-11-17 19:16:35,900 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:16:35 INFO - 2015-11-17 19:16:35,900 DEBUG : BROWSER_OUTPUT: 19:16:36 INFO - 2015-11-17 19:16:36,781 INFO : Browser exited with error code: 0 19:16:36 INFO - 2015-11-17 19:16:36,832 INFO : Completed test kraken (00:00:58) 19:16:36 INFO - 2015-11-17 19:16:36,832 INFO : Starting test v8_7 19:16:36 INFO - 2015-11-17 19:16:36,832 DEBUG : operating with platform_type : linux_ 19:16:36 INFO - 2015-11-17 19:16:36,832 INFO : Initialising browser for v8_7 test... 19:16:36 INFO - 2015-11-17 19:16:36,838 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8Csbwz/profile http://localhost:43172/getInfo.html 19:16:40 INFO - 2015-11-17 19:16:40,773 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:16:40 INFO - 2015-11-17 19:16:40,773 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:16:40 INFO - 2015-11-17 19:16:40,773 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:16:40 INFO - 2015-11-17 19:16:40,773 DEBUG : BROWSER_OUTPUT: __metrics 19:16:40 INFO - 2015-11-17 19:16:40,874 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:42 INFO - 2015-11-17 19:16:42,158 INFO : Browser initialized. 19:16:42 INFO - 2015-11-17 19:16:42,158 INFO : Running cycle 1/1 for v8_7 test... 19:16:42 INFO - 2015-11-17 19:16:42,158 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8Csbwz/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:53 INFO - 2015-11-17 19:16:53,908 DEBUG : BROWSER_OUTPUT: RSS: Main: 142012416 19:16:53 INFO - 2015-11-17 19:16:53,908 DEBUG : BROWSER_OUTPUT: 19:17:15 INFO - 2015-11-17 19:17:15,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43172/tests/v8_7/run.html (next: http://localhost:43172/tests/v8_7/run.html) 19:17:15 INFO - 2015-11-17 19:17:15,608 DEBUG : BROWSER_OUTPUT: RSS: Main: 616259584 19:17:15 INFO - 2015-11-17 19:17:15,608 DEBUG : BROWSER_OUTPUT: 19:17:15 INFO - 2015-11-17 19:17:15,610 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:17:15 INFO - 2015-11-17 19:17:15,610 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:17:15 INFO - 2015-11-17 19:17:15,610 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:17:15 INFO - 2015-11-17 19:17:15,610 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:17:15 INFO - 2015-11-17 19:17:15,610 DEBUG : BROWSER_OUTPUT: |0;Richards;164.90765171503958 19:17:15 INFO - 2015-11-17 19:17:15,610 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.1821603312006 19:17:15 INFO - 2015-11-17 19:17:15,611 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.29395218002816 19:17:15 INFO - 2015-11-17 19:17:15,611 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5081.218274111675 19:17:15 INFO - 2015-11-17 19:17:15,611 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2016.1290322580646 19:17:15 INFO - 2015-11-17 19:17:15,611 DEBUG : BROWSER_OUTPUT: |5;Earley;778.2101167315175 19:17:15 INFO - 2015-11-17 19:17:15,611 DEBUG : BROWSER_OUTPUT: |6;Boyer;12156.626506024097 19:17:15 INFO - 2015-11-17 19:17:15,611 DEBUG : BROWSER_OUTPUT: |7;RegExp;25150 19:17:15 INFO - 2015-11-17 19:17:15,612 DEBUG : BROWSER_OUTPUT: |8;Splay;651.4657980456026 19:17:15 INFO - 2015-11-17 19:17:15,612 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 19:17:15 INFO - 2015-11-17 19:17:15,612 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:17:15 INFO - 2015-11-17 19:17:15,612 DEBUG : BROWSER_OUTPUT: __startTimestamp1447816635609__endTimestamp 19:17:15 INFO - 2015-11-17 19:17:15,612 DEBUG : BROWSER_OUTPUT: 19:17:15 INFO - 2015-11-17 19:17:15,612 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:17:15 INFO - 2015-11-17 19:17:15,613 DEBUG : BROWSER_OUTPUT: Number of tests: 10 19:17:15 INFO - 2015-11-17 19:17:15,613 DEBUG : BROWSER_OUTPUT: 19:17:15 INFO - 2015-11-17 19:17:15,613 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.91 Median:164.91 stddev:0.00 (0.0%) 19:17:15 INFO - 2015-11-17 19:17:15,613 DEBUG : BROWSER_OUTPUT: Values: 164.9 19:17:15 INFO - 2015-11-17 19:17:15,613 DEBUG : BROWSER_OUTPUT: 19:17:15 INFO - 2015-11-17 19:17:15,613 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.18 Median:188.18 stddev:0.00 (0.0%) 19:17:15 INFO - 2015-11-17 19:17:15,614 DEBUG : BROWSER_OUTPUT: Values: 188.2 19:17:15 INFO - 2015-11-17 19:17:15,614 DEBUG : BROWSER_OUTPUT: 19:17:15 INFO - 2015-11-17 19:17:15,614 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.29 Median:281.29 stddev:0.00 (0.0%) 19:17:15 INFO - 2015-11-17 19:17:15,614 DEBUG : BROWSER_OUTPUT: Values: 281.3 19:17:15 INFO - 2015-11-17 19:17:15,614 DEBUG : BROWSER_OUTPUT: 19:17:15 INFO - 2015-11-17 19:17:15,614 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5081.22 Median:5081.22 stddev:0.00 (0.0%) 19:17:15 INFO - 2015-11-17 19:17:15,614 DEBUG : BROWSER_OUTPUT: Values: 5081.2 19:17:15 INFO - 2015-11-17 19:17:15,614 DEBUG : BROWSER_OUTPUT: 19:17:15 INFO - 2015-11-17 19:17:15,614 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2016.13 Median:2016.13 stddev:0.00 (0.0%) 19:17:15 INFO - 2015-11-17 19:17:15,614 DEBUG : BROWSER_OUTPUT: Values: 2016.1 19:17:15 INFO - 2015-11-17 19:17:15,614 DEBUG : BROWSER_OUTPUT: 19:17:15 INFO - 2015-11-17 19:17:15,614 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:778.21 Median:778.21 stddev:0.00 (0.0%) 19:17:15 INFO - 2015-11-17 19:17:15,614 DEBUG : BROWSER_OUTPUT: Values: 778.2 19:17:15 INFO - 2015-11-17 19:17:15,614 DEBUG : BROWSER_OUTPUT: 19:17:15 INFO - 2015-11-17 19:17:15,614 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12156.63 Median:12156.63 stddev:0.00 (0.0%) 19:17:15 INFO - 2015-11-17 19:17:15,614 DEBUG : BROWSER_OUTPUT: Values: 12156.6 19:17:15 INFO - 2015-11-17 19:17:15,615 DEBUG : BROWSER_OUTPUT: 19:17:15 INFO - 2015-11-17 19:17:15,615 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25150.00 Median:25150.00 stddev:0.00 (0.0%) 19:17:15 INFO - 2015-11-17 19:17:15,615 DEBUG : BROWSER_OUTPUT: Values: 25150.0 19:17:15 INFO - 2015-11-17 19:17:15,615 DEBUG : BROWSER_OUTPUT: 19:17:15 INFO - 2015-11-17 19:17:15,615 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:651.47 Median:651.47 stddev:0.00 (0.0%) 19:17:15 INFO - 2015-11-17 19:17:15,615 DEBUG : BROWSER_OUTPUT: Values: 651.5 19:17:15 INFO - 2015-11-17 19:17:15,615 DEBUG : BROWSER_OUTPUT: 19:17:15 INFO - 2015-11-17 19:17:15,615 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 19:17:15 INFO - 2015-11-17 19:17:15,615 DEBUG : BROWSER_OUTPUT: Values: 4830.9 19:17:15 INFO - 2015-11-17 19:17:15,615 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:17:15 INFO - 2015-11-17 19:17:15,615 DEBUG : BROWSER_OUTPUT: 19:17:16 INFO - 2015-11-17 19:17:16,421 INFO : Browser exited with error code: 0 19:17:16 INFO - 2015-11-17 19:17:16,440 INFO : Completed test v8_7 (00:00:39) 19:17:16 INFO - 2015-11-17 19:17:16,591 INFO : Completed test suite (00:20:10) 19:17:16 INFO - 2015-11-17 19:17:16,591 DEBUG : Working with test: dromaeo_css 19:17:16 INFO - 2015-11-17 19:17:16,591 DEBUG : Generating results file: dromaeo_css 19:17:16 INFO - 2015-11-17 19:17:16,592 DEBUG : Working with test: kraken 19:17:16 INFO - 2015-11-17 19:17:16,592 DEBUG : Generating results file: kraken 19:17:16 INFO - 2015-11-17 19:17:16,593 INFO : javascript benchmark 19:17:16 INFO - 2015-11-17 19:17:16,593 DEBUG : Working with test: v8_7 19:17:16 INFO - 2015-11-17 19:17:16,593 DEBUG : Generating results file: v8_7 19:17:16 INFO - 2015-11-17 19:17:16,593 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:17:16 INFO - 2015-11-17 19:17:16,645 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 19:17:16 INFO - 2015-11-17 19:17:16,646 DEBUG : process_Request line: dromaeo_css 6781.88 graph.html#tests=[[72,64,35]] 19:17:16 INFO - 2015-11-17 19:17:16,646 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:17:16 INFO - 2015-11-17 19:17:16,677 DEBUG : process_Request line: kraken 1498.10 graph.html#tests=[[232,64,35]] 19:17:16 INFO - 2015-11-17 19:17:16,678 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:17:16 INFO - 2015-11-17 19:17:16,707 DEBUG : process_Request line: v8_7 19805.06 graph.html#tests=[[230,64,35]] 19:17:16 INFO - 2015-11-17 19:17:16,709 INFO : javascript benchmark 19:17:16 INFO - 2015-11-17 19:17:16,713 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [350.18972743731536, 351.3026642115402, 355.8149762123695, 357.5209219645675, 362.85485805677723, 14440.133591984488, 14691.412343506274, 16668.249928753205, 16702.83297167028, 17393.913030434847, 16244.918775406106, 17022.82977170228, 17259.74110388345, 17316.567085822862, 17403.303867845272, 5289.814856480014, 5441.129419292914, 5441.401445840955, 5442.455754424565, 5445.401005889369, 3843.961560384402, 3929.7052721045893, 5362.490563396471, 5407.5133238008575, 5772.163036359725, 5929.555283353744, 5965.582409231356, 5982.940170598304, 5984.102384642317, 6002.96998515009, 5771.192033115367, 5846.795362162304, 5850.3564607893095, 5856.590038697293, 5858.443447872467, 5174.2238664200295, 5190.0, 5192.169252919514, 5195.064888320101, 5206.062908676437, 19767.0, 21200.0, 21680.34958951234, 21825.23611673584, 21853.0, 2104.705341252226, 2107.104480595756, 2217.46780772615, 2256.458449971995, 2310.330004298751, 12919.67700807478, 13039.934800326033, 13057.151285166528, 13345.33273336339, 13632.863671363259, 1771.4685594321782, 1795.066565386005, 1848.7781466224005, 1857.4984754116313, 1873.0, 57853.0, 59051.40948590545, 60158.69920650413, 60586.335503094626, 61267.0, 9962.0, 10172.949135254275, 10233.181345492343, 10244.385336879663, 10255.692329229985, 13093.279869607073, 13154.144980576231, 13179.14335568185, 13193.93403032998, 13223.404946777418, 7016.719331226694, 7033.929660703429, 7181.856362872713, 7231.638418079075, 7235.963820180866, 6508.934910650928, 6516.283208847023, 6527.673616319165, 6562.310957349505, 6571.080048793173, 6092.837042849813, 6124.5100391968535, 6162.322144564095, 6166.1983942087245, 6212.844678882973, 1668.4077152610892, 1726.3772054268948, 1740.7562941188244, 1742.9302827886743, 1752.8597712182996, 867.4621734524509, 878.4816957994686, 922.2437601167113, 934.2152591822901, 1032.8170907823285, 16372.83627163713, 17097.974121552747, 17902.731459028124, 18057.09714514269, 18070.3675371364, 933.1228645073609, 963.8145081549733, 986.4377304936118, 988.4958671077802, 997.6558087459815, 6077.483413909778, 6454.935450645434, 6577.671116444254, 6585.440237579764, 10163.542640581192, 530801.0, 533924.0, 541326.0, 543769.0, 545642.0, 41503.58496414997, 45934.31098533524, 45981.0, 72387.63806180935, 77542.0, 521.7782442461938, 535.7267793425381, 537.2022546518417, 537.4437457231746, 538.8168022872243, 11020.228583999044, 11196.776064478829, 11222.494987725735, 11346.432678365883, 11423.314601123959, 36863.26273474462, 37084.0, 37810.81094594619, 38089.42865856959, 38331.616683832806, 49125.508744913524, 49689.0, 50017.0, 51158.48841511686, 51701.22448163356, 6540.37866402691, 6833.726650933907, 6841.452683785185, 6843.486738494533, 6850.417714494324, 11976.880231197576, 12164.148509604243, 12185.14703970749, 12406.441710122886, 12422.813657794959, 7613.771586852404, 8757.91242087571, 10664.89335106639, 10752.784944301227, 10837.241393102722, 10077.244206684381, 10298.330608510423, 10482.266241363031, 10534.262601617813, 10582.947085264525, 10640.308379955279, 10688.73278168021, 10754.354738715701, 10917.072048875934, 10969.890301096886, 6748.527603067738, 6793.354631310018, 6814.829629259309, 6815.352541508549, 6816.659167041529, 10403.271770975958, 10644.0, 10669.57321707123, 10689.251752377259, 11055.391953442639], "dojo.html": [3127.515235138553, 3189.2186414328494, 3225.290436104058, 3225.3065590897954, 3248.366568519139, 5166.922496162551, 5320.6275560710765, 5328.200769884519, 5363.168708850129, 5382.327209098858, 5195.480451954802, 5282.498162674549, 5333.173358129487, 5361.544268737162, 5377.731113444322, 4901.387326584186, 4949.950500495003, 4957.5042495750495, 4982.501749825006, 5005.774740136702, 5005.474425185358, 5019.322391477141, 5061.797528098871, 5064.721440320781, 5073.239014147871, 4661.510541393139, 4809.759512024402, 4847.903041939141, 4865.270209468608, 4906.141425250603, 4918.163912134945, 4938.160512712848, 4945.67853089548, 4957.5042495750495, 4995.975020124913, 4904.6076313895155, 4940.555350018516, 4941.654084214107, 4963.354763880709, 5001.099802035632, 5148.124818780779, 5152.510511501401, 5258.290130832365, 5277.70972596507, 5285.577153827685, 5731.197632331477, 5863.0, 5874.823755287348, 5877.970610146965, 5891.970540147272, 5870.853228669274, 5883.23517942669, 5900.43945825146, 5902.498287645555, 5909.734061967179, 5292.391374991887, 5297.973510132425, 5387.46125387466, 5395.29861118056, 5424.783008679648, 5951.256092988377, 5981.282246130492, 6000.519958403317, 6043.667598282049, 6046.09308603713, 5532.612717109763, 5805.8548536286935, 5809.302883653989, 5817.214676018683, 5818.44724751148, 5768.913466298009, 5773.826785196451, 5880.176775251468, 5890.410958904161, 5920.141579471038, 5740.339860915965, 5744.885102298014, 5746.02317606008, 5746.655200687972, 5753.712314384264, 5525.309336332958, 5632.436756324417, 5723.570732195102, 5726.255586773693, 5731.0, 4369.126174764996, 4421.46942366918, 4424.048829501673, 4428.977855110704, 4454.242778727624, 3949.249642567903, 3950.881473555798, 3980.124372638015, 3995.2409042281874, 3998.28030954431, 5247.685138891678, 5346.0, 5410.513053825174, 5413.431589683105, 5448.673079615236, 5677.063284558001, 5780.364159942403, 5795.333536643256, 5804.593678442468, 5842.211301474246, 5473.0969390051, 5478.58910581708, 5485.4788795064405, 5487.5884308677005, 5503.2020357048, 4926.630502712311, 4965.602751779849, 5029.06962211992, 5072.51811077947, 5073.0, 5998.490128339053, 6102.786402475981, 6103.267607886994, 6106.145139680449, 6107.786227482017, 5913.172155898092, 5925.377835327228, 5926.792562260473, 5930.495907847881, 5934.6142500737315, 5739.770409183586, 5788.942110578841, 5893.6463812171405, 5905.645661260338, 6063.029915213545, 5803.709814509173, 5819.5344372450945, 5832.12518122285, 5833.82498525045, 5837.970810146092, 5883.382244864399, 5884.411558844253, 5884.588078834612, 5887.322957859729, 5896.204012458435, 5361.303030605996, 5468.207109968953, 5505.9724701376235, 5665.405132461032, 5740.540756739534, 5647.661140331593, 5650.406707295675, 5655.0, 5663.830085097454, 5755.683437410982, 5563.332400112013, 5565.471280228372, 5566.832995010156, 5573.191887176417, 5581.358143813351, 5499.945000550103, 5521.309836270466, 5577.247071645438, 5629.662220266797, 5664.26364572603, 5519.862003449785, 5578.609497335147, 5579.553635709215, 5620.494155526022, 5624.240727501735], "mootools.html": [1276.3107921722271, 1364.7748121559944, 1395.1629022586449, 1460.123925644613, 1514.1445083527806, 6665.133532640756, 7352.448566357524, 7584.241575842413, 7592.354649854762, 7597.088349398066, 7517.210692877251, 7617.695292188319, 7630.084389873223, 7645.0, 7653.464257501977, 2227.5544891021777, 2244.528648983707, 2246.6854640350366, 2249.302716157988, 2250.0437314141504, 2232.8660280383147, 2243.7083179186766, 2311.4914718761847, 2313.0747700919683, 2313.363824948136, 2211.7124773779387, 2240.271911628719, 2240.801171373316, 2242.4281808138985, 2244.663300504921, 2232.8213742900693, 2259.186692790602, 2260.2315212827634, 2267.0931627349028, 2267.7051983242236, 2218.0794970087395, 2226.8441209115367, 2229.030371788277, 2231.0518029837417, 2231.8884055797143, 6526.412622863965, 6659.467242620579, 7547.207543207939, 7575.053118360205, 7586.58273794941, 4127.6904232182405, 4494.550544945512, 4576.519465456146, 4579.519150489184, 4612.331211974279, 2928.633920759905, 2978.80637758545, 3019.3659331540402, 3021.5165573508134, 3060.342026464321, 956.2541217850019, 966.6375109334, 974.9853752193723, 987.9703608891673, 995.2038369304528, 10041.949790251076, 10063.0, 10068.0, 10070.848937265946, 10071.194304455626, 4099.487564054493, 4102.671786257092, 4146.937795933063, 4221.936670949938, 4229.598188172119, 8807.91192088071, 8824.691135810344, 8825.07336729647, 8827.205551500396, 8848.601812918434, 4589.059242855206, 4594.33382159585, 4623.791929363187, 4625.213713668684, 4631.745254010994, 4224.324108142682, 4228.1966426378885, 4228.6617070634275, 4230.471191101113, 4232.3016702243785, 3555.2711694102645, 3620.3845346291196, 3642.562892452923, 3652.141746689526, 3665.7617254878346, 1169.7601991591703, 1177.670252329349, 1186.1044911092242, 1196.1447564991074, 1198.8801119887942, 1094.042712626452, 1108.645233525264, 1110.4891749795186, 1116.4417791104447, 1156.2657712352548, 7124.715011399486, 7126.180489243699, 7143.82140446493, 7154.4991850571005, 7158.856822863513, 501.7315736081179, 502.09873277467034, 507.2999261019769, 511.50384127396364, 511.8298414721628, 5303.416624171338, 5691.260136182353, 5743.6789538405565, 5744.482996530249, 5755.0, 8064.717734879251, 8888.466691998501, 9194.356395052417, 9196.816063678689, 9200.861987070199, 8735.91264087351, 8947.642094316154, 8978.775530611787, 9006.63973441055, 9051.0, 6917.927721203221, 7029.507934444539, 7058.258882817333, 7067.505274630829, 7075.2570980047385, 6958.826029349307, 7016.6842492089, 7055.964720176366, 7063.682134304071, 7121.572705637678, 8051.597420129087, 8085.5957202140835, 8112.472689275178, 8200.42597018203, 8225.465344752572, 8268.875966860382, 8311.459755115899, 8452.408331416987, 8453.027901791373, 8465.619047143016, 6910.343517365842, 6978.79063628092, 6990.580565166107, 6991.405730512964, 6997.47518936092, 7076.115485564304, 7520.774376768706, 7526.360259378014, 7555.73554925597, 7556.8488630228185, 6584.407403333531, 6993.125859267591, 7055.118110236221, 7149.356557909813, 7181.281871812777, 6819.181698196248, 6881.311868813279, 6908.412784913137, 7046.0, 7074.257202993817, 6873.48448866347, 6896.0, 6932.410745086522, 6937.895931561132, 6959.095317608679, 6319.336469670802, 6421.261554921057, 6437.420632143129, 6443.67781610927, 6447.838804029937, 6389.233292004989, 6392.808215753535, 6445.2587952386075, 6446.64543450096, 6454.290028097], "ext.html": [561.0178194473498, 578.401354597991, 579.2383016333521, 586.437020460358, 593.7031484257872, 30842.845785771067, 31644.36711265776, 31682.841585792037, 40452.19095618086, 40902.0, 41970.58029419705, 42345.0, 42405.0, 42442.36336454956, 42510.0, 8761.912380876205, 8943.10568943107, 8948.328875334344, 8958.417702849327, 8959.104089591054, 7886.369090472748, 8070.192980701912, 8639.136086391341, 10384.221183411237, 10562.155027597812, 10419.0, 10521.316114452575, 10559.313644613114, 10566.471676416188, 10577.0, 7874.52752834826, 10428.947855260712, 10523.84214236787, 10534.262601617851, 10538.789224215472, 7741.458097933147, 9927.652532161339, 10135.341202821866, 10140.087392134743, 10148.89851101487, 33818.830905845556, 34126.65873341284, 34132.31735365304, 34146.0, 34163.0, 3240.9351812963846, 3295.0609076413107, 3509.491123787062, 3709.888703338904, 3916.0797212655, 26939.461210775673, 27107.322316942038, 27482.17553473399, 27616.861915690493, 27806.3048423789, 3410.693037626601, 3487.930241395183, 3494.72042236623, 3515.384807658675, 3603.0992251937014, 274614.0, 274929.0, 275077.0, 275693.0, 275728.6213568939, 56018.0, 56272.71863640656, 56281.43718562762, 56286.0, 56520.0, 57217.427825721206, 57333.14000289999, 57356.71321643365, 57714.42285577091, 57767.0, 14202.85797142036, 14406.351714172888, 14512.346944387527, 14555.490557830637, 14561.78157327641, 10922.945385273182, 10936.0, 11011.0, 11014.944925275322, 11017.559297628166, 18028.639427211383, 18205.27178912855, 18589.535261618297, 18655.720164197548, 18663.16015779266, 7260.165081015751, 7338.963305183546, 7417.443691723034, 7434.145073316529, 7539.886901696479, 919.6551293265026, 952.5332587032304, 970.7136394763562, 973.9269554783419, 1046.1682962045193, 25929.870350648125, 26222.868885655833, 26283.737162628127, 26330.0, 26430.07494737675, 908.0238743350924, 913.6025828764376, 1004.2267454060478, 1020.3775696824931, 1093.2456604942565, 12299.0, 13595.45618175262, 13654.522091726742, 13815.654608634864, 13908.235047072509, 318367.0, 321764.0, 321900.0, 322778.0, 323004.0, 48302.5169748298, 48540.27189592159, 48844.511554884, 48857.755711221216, 48931.755341223776, 1163.1857699610136, 1206.831043653889, 1228.0973484488893, 1260.9369531523387, 1321.914075585084, 25101.0, 26361.736382636696, 26483.337916552242, 26629.60055599129, 26650.733492664825, 39275.803620981715, 39467.2106557873, 39701.404478933415, 39775.0, 41895.7905210472, 254970.0, 306593.0, 318631.0, 318953.0, 321436.0, 27424.588631170947, 27685.30786730348, 27896.30259243454, 27935.720642794124, 27961.0, 39778.56664101436, 40984.38523422211, 41554.168916620896, 41557.0, 41562.792186038874, 34246.657533424346, 34434.13914652054, 34819.82590087033, 34891.0, 35325.470117947734, 33175.66824331726, 33562.0, 33636.0, 33688.831555842065, 34022.0, 33048.33903321968, 33075.83462082674, 33161.336773263916, 35072.9478115657, 35493.0, 28975.85512072426, 29881.252968675955, 30551.54172687367, 30582.0, 32370.838145810063, 23568.88215558911, 23853.0, 24499.265022049367, 25481.980720771702, 26903.596446052932], "prototype.html": [328.4793602140607, 332.36352385182374, 337.1756056442, 342.43498227923936, 342.7155460967397, 5958.493528050116, 6003.309619393771, 6049.334573196945, 6089.482393996515, 6090.299615544213, 5668.688222147791, 5823.272090988627, 5825.475707186352, 5938.554608404365, 5955.166276721252, 4606.97696511517, 4631.258998560231, 4647.047355292166, 4664.277037059262, 4665.510121437251, 4614.584687378136, 4637.8840528986875, 4651.3720647712635, 4651.651126165534, 4653.837115700934, 4370.868873933787, 4453.6437085033285, 4466.263066594008, 4578.542145785428, 4583.908321833561, 4574.88562785933, 4581.221192397301, 4584.7936842842155, 4592.448906131252, 4594.0, 4019.8995025124314, 4032.899177520556, 4039.9596004039877, 4042.514898212204, 4050.594940505926, 5693.060644993571, 5711.114777209497, 5711.543076553866, 5714.857128571777, 5725.599208055438, 5160.8967820643375, 5307.310049693515, 5311.389190243094, 5315.069862774038, 5316.627836051478, 6320.336364681734, 6324.241091069055, 6330.113784070234, 6332.905006424908, 6340.239171299428, 4390.868273951786, 4395.296752519582, 4396.274614688573, 4403.0533435311245, 4409.470863496401, 6480.930646443331, 6556.213254409454, 6579.93420065798, 6588.209414870151, 6633.867322653568, 4480.731156130642, 4483.461984561808, 4483.686141970031, 4485.237509623372, 4491.955080449219, 4538.228501154812, 4539.16025535277, 4541.568550987651, 4541.886452838706, 4545.545445455428, 5276.419593844674, 5278.524932755993, 5282.260483532308, 5282.524572788468, 5285.2600635911, 6289.088082228142, 6411.487081033506, 6418.358164183638, 6424.518161137933, 6426.710798014101, 1589.7535881938318, 1607.4213283218032, 1609.501054673055, 1610.9838901610833, 1611.427943080213, 1046.3826342457987, 1060.5015642647943, 1069.2515239332342, 1073.9087177589993, 1075.6127793994156, 6175.505959523227, 6181.227346581677, 6183.288921774054, 6185.381461853779, 6194.628322300677, 6588.8023359299295, 6591.769288074895, 6599.340065993459, 6610.338966103352, 6614.404703576702, 5959.612625179436, 6049.153118563405, 6051.818445446644, 6170.753169873155, 6180.938190618126, 3543.9822800886345, 3595.0832537702718, 3596.17288023756, 3599.3161299353037, 3606.04439823447, 6870.484713646497, 6879.277675843964, 6880.380765731108, 6881.965590172017, 6883.242843287235, 6692.397684208445, 6865.592553526515, 6870.587764734132, 6880.58716477003, 6880.827979300558, 6871.793846184622, 6874.2094659113845, 6875.449964002868, 6879.58722476653, 6893.965530172317, 6551.377619126175, 6682.264950855305, 6682.532222744361, 6684.532082754161, 6687.665616719242, 6544.411003009752, 6584.901226481511, 6600.80197594073, 6601.603903765789, 6602.471802255904, 6859.657017149222, 6862.622555759481, 6863.691133899087, 6868.381845633917, 6870.866307059479, 4462.620677242471, 4472.530384309731, 4474.3959565459545, 4478.880279930017, 4482.529334419839, 6514.478841692748, 6657.467402607683, 6662.433693135944, 6669.799906002828, 6682.665866706548, 6477.77327793525, 6479.7408103675325, 6486.481081513562, 6492.318306577741, 6505.674716264073, 6370.044493326038, 6443.323451037573, 6470.320616335405, 6481.222253329631, 6482.902756458751, 6341.841453963688, 6354.809355719336, 6362.586431881913, 6370.331115232834, 6371.553991220755, 6509.7396104155305, 6515.478761699147, 6516.706748196248, 6517.478601711757, 6521.413072823469, 6208.192934918432, 6338.778142764981, 6349.714262858275, 6360.300366959723, 6363.5227357947415], "yui.html": [669.7354544954743, 684.1038239905724, 685.6057766784099, 695.2387136085987, 718.2924819053235, 13228.14017088891, 13241.470341186365, 13293.7341253175, 13340.0, 13341.53304634338, 13022.674433139176, 13191.538296159611, 13231.338433078332, 13237.801432978513, 13264.071514993955, 678.0304165043985, 683.6615875141812, 708.6208878250137, 716.451914285572, 807.7415227127336, 815.3925325632412, 815.559597817178, 821.4085858182129, 822.5887056471764, 822.7408366364606, 702.5257950883159, 850.0267194062794, 851.8424091543053, 854.3080105114877, 854.5470900422786, 703.3704834173411, 842.1578421578422, 853.6542700206395, 859.9140085991413, 860.4450129666393, 624.1293395712955, 630.5176539946945, 630.8328293002359, 630.9432151106377, 631.4127861089186, 12221.327826969513, 12243.142979991404, 12267.447964841514, 12295.262284262973, 12312.076594255466, 11945.581904633384, 12016.158868879182, 12393.132480726354, 12439.191452555555, 12663.11358204926, 10214.744631384201, 10259.69220923366, 10270.794584108276, 10477.37135771856, 10509.211809114347, 3554.662307080823, 3582.6417358263966, 3602.2615363850346, 3617.3307938031285, 3732.029672285198, 46521.06957860858, 46587.30119048217, 46628.3005754914, 46682.76658616719, 46767.29849052267, 9047.411918225425, 9115.134062264075, 9192.402493837879, 9232.307576931757, 9461.290403219786, 17045.31818727237, 17055.829441705424, 17083.40208092711, 17088.0, 17097.401590944257, 7129.572225666477, 7212.71149154028, 7289.890651640229, 7352.301531354619, 7394.149672787591, 4271.700980931367, 4338.414314067623, 4394.934075988863, 4493.370928070073, 4496.685232033792, 2706.553418685934, 2753.6833264174475, 2771.196353057631, 2772.5841123831588, 2773.2234974207254, 440.8985933235374, 453.6393567114152, 456.74878816651375, 463.03688328277104, 464.21315869601375, 606.3300053440972, 621.2638023941553, 630.782380078872, 634.9492040636738, 638.409471239102, 8210.794730131794, 8983.865242021375, 9143.13140251675, 9265.814683706289, 9489.288303377274, 491.4397586751107, 660.5805313625882, 679.58205703492, 680.2245440198178, 705.2383425900016, 4040.6363427291685, 4092.345224764083, 4220.345846393814, 4228.3234682451275, 4242.830286788556, 61708.38291617116, 62110.689446553384, 62149.0, 62200.68899655563, 62214.0, 52223.216651750256, 53698.0, 53701.0, 53717.0, 53766.46233537693, 48594.514054859705, 49211.0, 49575.0, 49597.75201123971, 49834.25248621274, 7922.366210703015, 7994.680212791423, 8045.155258697752, 8057.355411567178, 8254.793630159054, 34008.489872652426, 34928.82535587306, 35736.106597335274, 35970.28059438849, 36064.27871442504, 45056.324155137045, 46223.0, 46473.76763116163, 46827.53172468232, 47690.28464573104, 7787.688492460465, 7919.445638805459, 8285.212904774036, 8290.46112002718, 8369.83260334802, 12095.75808483843, 12231.266124032587, 12234.20155842101, 12340.136190466581, 13016.15394999322, 10417.322874013165, 10519.631812886511, 10657.520411581343, 10908.072813810915, 10916.727081823017, 10603.522841472306, 10939.56241750321, 11022.0, 11325.433728313716, 11706.697619968834, 7462.514936529108, 10198.286119971532, 10522.263441559018, 10705.090067344363, 10755.139588832719, 9173.724788256362, 9225.308101892251, 9336.253099752139, 9520.666776662783, 9607.759806004906, 8805.471671699463, 9053.818923621622, 9276.675316363895, 9384.530773461436, 9483.620655173716]}, "summary": {"lowerIsBetter": false, "suite": 6781.873684005929, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 8113.812552638592, "unit": "ms", "value": 8113.812552638592}, "dojo.html": {"lowerIsBetter": false, "filtered": 5338.348435368118, "unit": "ms", "value": 5338.348435368118}, "mootools.html": {"lowerIsBetter": false, "filtered": 4289.9373202495035, "unit": "ms", "value": 4289.9373202495035}, "ext.html": {"lowerIsBetter": false, "filtered": 17846.37691025317, "unit": "ms", "value": 17846.37691025317}, "prototype.html": {"lowerIsBetter": false, "filtered": 4820.935898209418, "unit": "ms", "value": 4820.935898209418}, "yui.html": {"lowerIsBetter": false, "filtered": 6085.499941701609, "unit": "ms", "value": 6085.499941701609}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-026"}, "testrun": {"date": 1447815425, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151117173015", "branch": "Fx-Team", "revision": "8e712e56faf8ef12537ad604f38bca4f06665a7b"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 161.0, 162.0, 162.0, 161.0, 161.0, 159.0, 164.0, 161.0, 161.0], "ai-astar": [108.0, 110.0, 103.0, 109.0, 108.0, 109.0, 99.0, 111.0, 109.0, 104.0], "imaging-gaussian-blur": [109.0, 109.0, 110.0, 110.0, 109.0, 108.0, 108.0, 108.0, 109.0, 109.0], "audio-beat-detection": [155.0, 123.0, 150.0, 164.0, 127.0, 146.0, 159.0, 125.0, 169.0, 129.0], "json-stringify-tinderbox": [70.0, 69.0, 69.0, 69.0, 70.0, 70.0, 69.0, 70.0, 70.0, 70.0], "stanford-crypto-pbkdf2": [138.0, 146.0, 148.0, 154.0, 145.0, 139.0, 155.0, 150.0, 157.0, 141.0], "json-parse-financial": [58.0, 58.0, 58.0, 57.0, 58.0, 57.0, 58.0, 67.0, 55.0, 56.0], "stanford-crypto-sha256-iterative": [66.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0, 65.0, 66.0], "audio-fft": [73.0, 73.0, 82.0, 93.0, 72.0, 73.0, 72.0, 104.0, 93.0, 74.0], "imaging-darkroom": [147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 147.0], "stanford-crypto-ccm": [126.0, 121.0, 126.0, 117.0, 114.0, 130.0, 126.0, 124.0, 136.0, 122.0], "audio-oscillator": [90.0, 90.0, 134.0, 90.0, 90.0, 90.0, 145.0, 90.0, 90.0, 133.0], "stanford-crypto-aes": [85.0, 83.0, 85.0, 83.0, 84.0, 84.0, 85.0, 84.0, 84.0, 86.0], "imaging-desaturate": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1498.1000000000001, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 80.9, "unit": "ms", "value": 80.9}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 147.3, "unit": "ms", "value": 147.3}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 144.7, "unit": "ms", "value": 144.7}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 124.2, "unit": "ms", "value": 124.2}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 146.0, "unit": "ms", "value": 146.0}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 58.2, "unit": "ms", "value": 58.2}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 104.2, "unit": "ms", "value": 104.2}, "ai-astar": {"lowerIsBetter": true, "filtered": 107.0, "unit": "ms", "value": 107.0}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.4, "unit": "ms", "value": 161.4}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 65.4, "unit": "ms", "value": 65.4}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.6, "unit": "ms", "value": 69.6}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 108.9, "unit": "ms", "value": 108.9}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 84.3, "unit": "ms", "value": 84.3}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.0, "unit": "ms", "value": 96.0}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-026"}, "testrun": {"date": 1447815425, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151117173015", "branch": "Fx-Team", "revision": "8e712e56faf8ef12537ad604f38bca4f06665a7b"}}, {"talos_counters": {}, "results": {"DeltaBlue": [188.1821603312006], "Encrypt": [281.29395218002816], "NavierStokes": [4830.917874396136], "Decrypt": [5081.218274111675], "Splay": [651.4657980456026], "Richards": [164.90765171503958], "RegExp": [25150.0], "Earley": [778.2101167315175], "Boyer": [12156.626506024097], "RayTrace": [2016.1290322580646]}, "summary": {"lowerIsBetter": false, "suite": 19805.061155826843, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 351.351052, "unit": "score", "value": 351.351052}, "Encrypt": {"lowerIsBetter": false, "filtered": 946.2734550000002, "unit": "score", "value": 946.2734550000002}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.1879999999999, "unit": "score", "value": 307.1879999999999}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.38527172827171, "unit": "score", "value": 52.38527172827171}, "Splay": {"lowerIsBetter": false, "filtered": 125.08868499999998, "unit": "score", "value": 125.08868499999998}, "RegExp": {"lowerIsBetter": false, "filtered": 36.22206759443341, "unit": "score", "value": 36.22206759443341}, "Richards": {"lowerIsBetter": false, "filtered": 214.07132799999994, "unit": "score", "value": 214.07132799999994}, "Earley": {"lowerIsBetter": false, "filtered": 856.4049549999997, "unit": "score", "value": 856.4049549999997}, "Boyer": {"lowerIsBetter": false, "filtered": 54.82302180376615, "unit": "score", "value": 54.82302180376615}, "RayTrace": {"lowerIsBetter": false, "filtered": 367.03454399999987, "unit": "score", "value": 367.03454399999987}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-026"}, "testrun": {"date": 1447815425, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151117173015", "branch": "Fx-Team", "revision": "8e712e56faf8ef12537ad604f38bca4f06665a7b"}}] 19:17:16 INFO - RETURN: dromaeo_css: 6781.88 19:17:16 INFO - RETURN: kraken: 1498.10 19:17:16 INFO - RETURN: v8_7: 19805.06 19:17:16 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19805.06"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1498.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6781.88"}}} 19:17:16 INFO - Return code: 0 19:17:16 INFO - # TBPL SUCCESS # 19:17:16 INFO - Running post-action listener: _resource_record_post_action 19:17:16 INFO - Running post-run listener: _resource_record_post_run 19:17:17 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 73728; Write bytes: 505614336; Read time: 24; Write time: 683536 19:17:17 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 221999104; Read time: 0; Write time: 349044 19:17:17 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 69632; Write bytes: 265404416; Read time: 12; Write time: 217868 19:17:17 INFO - Running post-run listener: _upload_blobber_files 19:17:17 INFO - Blob upload gear active. 19:17:17 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 19:17:17 INFO - Copying logs to upload dir... 19:17:17 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1254.972989 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2015-11-17 19:17:17.869866) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 19:17:17.873297) ========= 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=a65b340e283ce644d68cb24e000001c9-1447815148.607166-20276609 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010091 build_url: 'https://queue.taskcluster.net/v1/task/nX3YYY2xQDeU6ir8qOW_zg/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-17 19:17:17.927198) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 19:17:17.927586) ========= 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=a65b340e283ce644d68cb24e000001c9-1447815148.607166-20276609 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004615 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 19:17:17.977635) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 19:17:17.978013) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 19:17:17.978422) ========= ========= Total master_lag: 0.24 =========