builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-017 starttime: 1447721015.82 results: success (0) buildid: 20151116143020 builduid: abf6a89cf0a147308f88a82377fff8b6 revision: 2feb5677ea5cedb035700076148065deb08fb3aa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 16:43:35.819072) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 16:43:35.819706) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 16:43:35.820294) ========= 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=6587686cb2da90a5f91b3170000001be-1447719739.442651-1430312401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006457 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 16:43:35.845123) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 16:43:35.845400) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 16:43:35.863317) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 16:43:35.863582) ========= 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=6587686cb2da90a5f91b3170000001be-1447719739.442651-1430312401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 16:43:35.916589) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 16:43:35.917065) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 16:43:35.917658) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 16:43:35.918090) ========= 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=6587686cb2da90a5f91b3170000001be-1447719739.442651-1430312401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-16 16:43:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2015-11-16 16:43:36 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176420 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 16:43:36.107534) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 16:43:36.107815) ========= 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=6587686cb2da90a5f91b3170000001be-1447719739.442651-1430312401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020979 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 16:43:36.158661) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 16:43:36.158981) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2feb5677ea5cedb035700076148065deb08fb3aa --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 2feb5677ea5cedb035700076148065deb08fb3aa --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=6587686cb2da90a5f91b3170000001be-1447719739.442651-1430312401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-16 16:43:36,360 truncating revision to first 12 chars 2015-11-16 16:43:36,360 Setting DEBUG logging. 2015-11-16 16:43:36,360 attempt 1/10 2015-11-16 16:43:36,360 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2feb5677ea5c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 16:43:36,601 unpacking tar archive at: fx-team-2feb5677ea5c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.533073 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 16:43:36.705889) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 16:43:36.706208) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 16:43:36.716475) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 16:43:36.716730) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 16:43:36.717139) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-11-16 16:43:36.717416) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6587686cb2da90a5f91b3170000001be-1447719739.442651-1430312401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:43:36 INFO - MultiFileLogger online at 20151116 16:43:36 in /builds/slave/test-pgo 16:43:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:43:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:43:37 INFO - {'append_to_log': False, 16:43:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:43:37 INFO - 'blob_upload_branch': 'Fx-Team', 16:43:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:43:37 INFO - 'branch': 'Fx-Team', 16:43:37 INFO - 'buildbot_json_path': 'buildprops.json', 16:43:37 INFO - 'config_files': ('talos/linux_config.py',), 16:43:37 INFO - 'default_actions': ('clobber', 16:43:37 INFO - 'read-buildbot-config', 16:43:37 INFO - 'download-and-extract', 16:43:37 INFO - 'populate-webroot', 16:43:37 INFO - 'create-virtualenv', 16:43:37 INFO - 'install', 16:43:37 INFO - 'run-tests'), 16:43:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:43:37 INFO - 'download_minidump_stackwalk': True, 16:43:37 INFO - 'download_symbols': 'ondemand', 16:43:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:43:37 INFO - 'tooltool.py': '/tools/tooltool.py', 16:43:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:43:37 INFO - '/tools/misc-python/virtualenv.py')}, 16:43:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:43:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:43:37 INFO - 'installer_path': 'installer.exe', 16:43:37 INFO - 'log_level': 'info', 16:43:37 INFO - 'log_name': 'talos', 16:43:37 INFO - 'log_to_console': True, 16:43:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:43:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:43:37 INFO - 'opt_config_files': (), 16:43:37 INFO - 'pip_index': False, 16:43:37 INFO - 'sps_profile': False, 16:43:37 INFO - 'sps_profile_interval': 0, 16:43:37 INFO - 'suite': 'dromaeojs-e10s', 16:43:37 INFO - 'system_bits': '64', 16:43:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:43:37 INFO - 'title': 'talos-linux64-ix-017', 16:43:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:43:37 INFO - 'use_talos_json': True, 16:43:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:43:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:43:37 INFO - 'work_dir': 'build'} 16:43:37 INFO - ##### 16:43:37 INFO - ##### Running clobber step. 16:43:37 INFO - ##### 16:43:37 INFO - Running pre-action listener: _resource_record_pre_action 16:43:37 INFO - Running main action method: clobber 16:43:37 INFO - rmtree: /builds/slave/test-pgo/build 16:43:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:43:37 INFO - Running post-action listener: _resource_record_post_action 16:43:37 INFO - ##### 16:43:37 INFO - ##### Running read-buildbot-config step. 16:43:37 INFO - ##### 16:43:37 INFO - Running pre-action listener: _resource_record_pre_action 16:43:37 INFO - Running main action method: read_buildbot_config 16:43:37 INFO - Using buildbot properties: 16:43:37 INFO - { 16:43:37 INFO - "properties": { 16:43:37 INFO - "buildnumber": 337, 16:43:37 INFO - "product": "firefox", 16:43:37 INFO - "script_repo_revision": "production", 16:43:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 16:43:37 INFO - "repository": "", 16:43:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 16:43:37 INFO - "buildid": "20151116143020", 16:43:37 INFO - "slavename": "talos-linux64-ix-017", 16:43:37 INFO - "pgo_build": "True", 16:43:37 INFO - "basedir": "/builds/slave/test-pgo", 16:43:37 INFO - "project": "", 16:43:37 INFO - "platform": "ubuntu64_hw", 16:43:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:43:37 INFO - "slavebuilddir": "test", 16:43:37 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 16:43:37 INFO - "branch": "fx-team", 16:43:37 INFO - "repo_path": "integration/fx-team", 16:43:37 INFO - "stage_platform": "linux64-pgo", 16:43:37 INFO - "builduid": "abf6a89cf0a147308f88a82377fff8b6", 16:43:37 INFO - "revision": "2feb5677ea5cedb035700076148065deb08fb3aa" 16:43:37 INFO - }, 16:43:37 INFO - "sourcestamp": { 16:43:37 INFO - "repository": "", 16:43:37 INFO - "hasPatch": false, 16:43:37 INFO - "project": "", 16:43:37 INFO - "branch": "fx-team-linux64-pgo-talos", 16:43:37 INFO - "changes": [ 16:43:37 INFO - { 16:43:37 INFO - "category": null, 16:43:37 INFO - "files": [ 16:43:37 INFO - { 16:43:37 INFO - "url": null, 16:43:37 INFO - "name": "https://queue.taskcluster.net/v1/task/JgTPEMinQ_iadziymxeNyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 16:43:37 INFO - } 16:43:37 INFO - ], 16:43:37 INFO - "repository": "", 16:43:37 INFO - "rev": "2feb5677ea5cedb035700076148065deb08fb3aa", 16:43:37 INFO - "who": "sendchange", 16:43:37 INFO - "when": 1447720979, 16:43:37 INFO - "number": 6669072, 16:43:37 INFO - "comments": "", 16:43:37 INFO - "project": "", 16:43:37 INFO - "at": "Mon 16 Nov 2015 16:42:59", 16:43:37 INFO - "branch": "fx-team-linux64-pgo-talos", 16:43:37 INFO - "revlink": "", 16:43:37 INFO - "properties": [ 16:43:37 INFO - [ 16:43:37 INFO - "buildid", 16:43:37 INFO - "20151116143020", 16:43:37 INFO - "Change" 16:43:37 INFO - ], 16:43:37 INFO - [ 16:43:37 INFO - "builduid", 16:43:37 INFO - "abf6a89cf0a147308f88a82377fff8b6", 16:43:37 INFO - "Change" 16:43:37 INFO - ], 16:43:37 INFO - [ 16:43:37 INFO - "pgo_build", 16:43:37 INFO - "True", 16:43:37 INFO - "Change" 16:43:37 INFO - ] 16:43:37 INFO - ], 16:43:37 INFO - "revision": "2feb5677ea5cedb035700076148065deb08fb3aa" 16:43:37 INFO - } 16:43:37 INFO - ], 16:43:37 INFO - "revision": "2feb5677ea5cedb035700076148065deb08fb3aa" 16:43:37 INFO - } 16:43:37 INFO - } 16:43:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/JgTPEMinQ_iadziymxeNyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 16:43:37 INFO - Running post-action listener: _resource_record_post_action 16:43:37 INFO - ##### 16:43:37 INFO - ##### Running download-and-extract step. 16:43:37 INFO - ##### 16:43:37 INFO - Running pre-action listener: _resource_record_pre_action 16:43:37 INFO - Running main action method: download_and_extract 16:43:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:43: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')]} 16:43:37 INFO - https://queue.taskcluster.net/v1/task/JgTPEMinQ_iadziymxeNyw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:43:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JgTPEMinQ_iadziymxeNyw/artifacts/public/build/test_packages.json 16:43:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JgTPEMinQ_iadziymxeNyw/artifacts/public/build/test_packages.json 16:43:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JgTPEMinQ_iadziymxeNyw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:43:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JgTPEMinQ_iadziymxeNyw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:43:44 INFO - Downloaded 1302 bytes. 16:43:44 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:43:44 INFO - Using the following test package requirements: 16:43:44 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:43:44 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:43:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:43:44 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:43:44 INFO - u'jsshell-linux-x86_64.zip'], 16:43:44 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:43:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:43:44 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:43:44 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:43:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:43:44 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:43:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:43:44 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:43:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:43:44 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:43:44 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:43:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:43:44 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:44 INFO - https://queue.taskcluster.net/v1/task/JgTPEMinQ_iadziymxeNyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:43:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JgTPEMinQ_iadziymxeNyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:43:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JgTPEMinQ_iadziymxeNyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:43:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JgTPEMinQ_iadziymxeNyw/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 16:43:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JgTPEMinQ_iadziymxeNyw/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 16:43:52 INFO - Downloaded 22458470 bytes. 16:43:52 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 16:43:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:43:52 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 16:43:53 INFO - Return code: 0 16:43:53 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 16:43:53 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')]} 16:43:53 INFO - https://queue.taskcluster.net/v1/task/JgTPEMinQ_iadziymxeNyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:43:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JgTPEMinQ_iadziymxeNyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:43:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JgTPEMinQ_iadziymxeNyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:43:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JgTPEMinQ_iadziymxeNyw/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 16:43:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JgTPEMinQ_iadziymxeNyw/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 16:43:56 INFO - Downloaded 22458470 bytes. 16:43:56 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 16:43:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:43:56 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 16:43:57 INFO - Return code: 0 16:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:57 INFO - https://queue.taskcluster.net/v1/task/JgTPEMinQ_iadziymxeNyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:43:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JgTPEMinQ_iadziymxeNyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:43:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JgTPEMinQ_iadziymxeNyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:43:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JgTPEMinQ_iadziymxeNyw/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 16:43:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JgTPEMinQ_iadziymxeNyw/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 16:43:58 INFO - Downloaded 11131693 bytes. 16:43:58 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 16:43:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:43:58 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 16:43:58 INFO - Return code: 0 16:43:58 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')]} 16:43:58 INFO - https://queue.taskcluster.net/v1/task/JgTPEMinQ_iadziymxeNyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:43:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JgTPEMinQ_iadziymxeNyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:43:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JgTPEMinQ_iadziymxeNyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:43:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JgTPEMinQ_iadziymxeNyw/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 16:43:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JgTPEMinQ_iadziymxeNyw/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 16:44:00 INFO - Downloaded 57138936 bytes. 16:44:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JgTPEMinQ_iadziymxeNyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:44:00 INFO - mkdir: /builds/slave/test-pgo/properties 16:44:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:44:00 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:44:00 INFO - Contents: 16:44:00 INFO - build_url:https://queue.taskcluster.net/v1/task/JgTPEMinQ_iadziymxeNyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:44:00 INFO - Running post-action listener: _resource_record_post_action 16:44:00 INFO - Running post-action listener: set_extra_try_arguments 16:44:00 INFO - ##### 16:44:00 INFO - ##### Running populate-webroot step. 16:44:00 INFO - ##### 16:44:00 INFO - Running pre-action listener: _resource_record_pre_action 16:44:00 INFO - Running main action method: populate_webroot 16:44:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:44:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:44:00 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 16:44:00 INFO - '../fennec_ids.txt'], 16:44:00 INFO - 'tests': ['tcheck2']}, 16:44:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:44:00 INFO - '--tppagecycles', 16:44:00 INFO - '7'], 16:44:00 INFO - 'tests': ['tsvgm']}}, 16:44:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:44:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:44:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:44:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:44:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:44:00 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:44:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:44:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:00 INFO - 'talos_options': ['--e10s'], 16:44:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:44:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:00 INFO - 'tests': ['damp', 'tps']}, 16:44:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:00 INFO - 'talos_options': ['--e10s'], 16:44:00 INFO - 'tests': ['damp', 'tps']}, 16:44:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:44:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:44:00 INFO - 'other': {'tests': ['a11yr', 16:44:00 INFO - 'ts_paint', 16:44:00 INFO - 'tpaint', 16:44:00 INFO - 'sessionrestore', 16:44:00 INFO - 'sessionrestore_no_auto_restore']}, 16:44:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:44:00 INFO - 'tests': ['a11yr', 16:44:00 INFO - 'ts_paint', 16:44:00 INFO - 'tpaint', 16:44:00 INFO - 'sessionrestore', 16:44:00 INFO - 'sessionrestore_no_auto_restore']}, 16:44:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:44:00 INFO - 'tests': ['a11yr', 16:44:00 INFO - 'ts_paint', 16:44:00 INFO - 'tpaint', 16:44:00 INFO - 'sessionrestore', 16:44:00 INFO - 'sessionrestore_no_auto_restore']}, 16:44:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:44:00 INFO - 'tests': ['a11yr', 16:44:00 INFO - 'ts_paint', 16:44:00 INFO - 'tpaint', 16:44:00 INFO - 'sessionrestore', 16:44:00 INFO - 'sessionrestore_no_auto_restore']}, 16:44:00 INFO - 'other_l64': {'tests': ['a11yr', 16:44:00 INFO - 'ts_paint', 16:44:00 INFO - 'tpaint', 16:44:00 INFO - 'sessionrestore', 16:44:00 INFO - 'sessionrestore_no_auto_restore']}, 16:44:00 INFO - 'other_nol64': {'tests': ['a11yr', 16:44:00 INFO - 'ts_paint', 16:44:00 INFO - 'tpaint', 16:44:00 INFO - 'sessionrestore', 16:44:00 INFO - 'sessionrestore_no_auto_restore']}, 16:44:00 INFO - 'svgr': {'tests': ['tsvgx', 16:44:00 INFO - 'tsvgr_opacity', 16:44:00 INFO - 'tart', 16:44:00 INFO - 'tscrollx', 16:44:00 INFO - 'cart']}, 16:44:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:44:00 INFO - 'tests': ['tsvgx', 16:44:00 INFO - 'tsvgr_opacity', 16:44:00 INFO - 'tart', 16:44:00 INFO - 'tscrollx', 16:44:00 INFO - 'cart']}, 16:44:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:00 INFO - 'tests': ['tp5o']}, 16:44:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:00 INFO - 'talos_options': ['--e10s'], 16:44:00 INFO - 'tests': ['tp5o']}, 16:44:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:00 INFO - 'talos_options': ['--xperf_path', 16:44:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:44:00 INFO - 'tests': ['tp5n']}, 16:44:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:00 INFO - 'talos_options': ['--e10s', 16:44:00 INFO - '--xperf_path', 16:44:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:44:00 INFO - 'tests': ['tp5n']}}, 16:44:00 INFO - 'talos.zip': {'path': '', 16:44:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:44:00 INFO - Running post-action listener: _resource_record_post_action 16:44:00 INFO - ##### 16:44:00 INFO - ##### Running create-virtualenv step. 16:44:00 INFO - ##### 16:44:00 INFO - Running pre-action listener: _resource_record_pre_action 16:44:00 INFO - Running main action method: create_virtualenv 16:44:00 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:44:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 16:44:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:44:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:44:00 INFO - Using real prefix '/usr' 16:44:00 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:44:01 INFO - Installing distribute.............................................................................................................................................................................................done. 16:44:03 INFO - Installing pip.................done. 16:44:03 INFO - Return code: 0 16:44:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcc1a39c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ec6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ad3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25368c0>, '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 0x24e3420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e38b0>, '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': '6587686cb2da90a5f91b3170000001be-1447719739.442651-1430312401', '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 16:44:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 16:44:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:44:03 INFO - Using env: {'DISPLAY': ':0', 16:44:03 INFO - 'HOME': '/home/cltbld', 16:44:03 INFO - 'LANG': 'en_US.UTF-8', 16:44:03 INFO - 'LANGUAGE': 'en_US:en', 16:44:03 INFO - 'LOGNAME': 'cltbld', 16:44:03 INFO - 'MAIL': '/var/mail/cltbld', 16:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:03 INFO - 'MOZ_NO_REMOTE': '1', 16:44:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:03 INFO - 'NO_EM_RESTART': '1', 16:44:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:44:03 INFO - 'PWD': '/builds/slave/test-pgo', 16:44:03 INFO - 'SHELL': '/bin/bash', 16:44:03 INFO - 'SHLVL': '1', 16:44:03 INFO - 'TERM': 'linux', 16:44:03 INFO - 'TMOUT': '86400', 16:44:03 INFO - 'USER': 'cltbld', 16:44:03 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447719739.442651-1430312401', 16:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:03 INFO - '_': '/tools/buildbot/bin/python'} 16:44:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:44:03 INFO - Cleaning up... 16:44:03 INFO - Return code: 0 16:44:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcc1a39c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ec6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ad3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25368c0>, '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 0x24e3420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e38b0>, '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': '6587686cb2da90a5f91b3170000001be-1447719739.442651-1430312401', '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 16:44:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 16:44:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:44:03 INFO - Using env: {'DISPLAY': ':0', 16:44:03 INFO - 'HOME': '/home/cltbld', 16:44:03 INFO - 'LANG': 'en_US.UTF-8', 16:44:03 INFO - 'LANGUAGE': 'en_US:en', 16:44:03 INFO - 'LOGNAME': 'cltbld', 16:44:03 INFO - 'MAIL': '/var/mail/cltbld', 16:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:03 INFO - 'MOZ_NO_REMOTE': '1', 16:44:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:03 INFO - 'NO_EM_RESTART': '1', 16:44:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:44:03 INFO - 'PWD': '/builds/slave/test-pgo', 16:44:03 INFO - 'SHELL': '/bin/bash', 16:44:03 INFO - 'SHLVL': '1', 16:44:03 INFO - 'TERM': 'linux', 16:44:03 INFO - 'TMOUT': '86400', 16:44:03 INFO - 'USER': 'cltbld', 16:44:03 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447719739.442651-1430312401', 16:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:03 INFO - '_': '/tools/buildbot/bin/python'} 16:44:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:03 INFO - Downloading/unpacking psutil>=0.7.1 16:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:05 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 16:44:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:44:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:44:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:44:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:44:05 INFO - Installing collected packages: psutil 16:44:05 INFO - Running setup.py install for psutil 16:44:05 INFO - building 'psutil._psutil_linux' extension 16:44:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:44:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:44:05 INFO - building 'psutil._psutil_posix' extension 16:44:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:44:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:44:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:44:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:44:05 INFO - Successfully installed psutil 16:44:05 INFO - Cleaning up... 16:44:05 INFO - Return code: 0 16:44:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:44: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')]} 16:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44: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')]} 16:44:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:05 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 0x7fbcc1a39c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ec6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ad3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25368c0>, '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 0x24e3420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e38b0>, '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': '6587686cb2da90a5f91b3170000001be-1447719739.442651-1430312401', '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 16:44:05 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 16:44:05 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 16:44:05 INFO - Using env: {'DISPLAY': ':0', 16:44:05 INFO - 'HOME': '/home/cltbld', 16:44:05 INFO - 'LANG': 'en_US.UTF-8', 16:44:05 INFO - 'LANGUAGE': 'en_US:en', 16:44:05 INFO - 'LOGNAME': 'cltbld', 16:44:05 INFO - 'MAIL': '/var/mail/cltbld', 16:44:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:05 INFO - 'MOZ_NO_REMOTE': '1', 16:44:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:05 INFO - 'NO_EM_RESTART': '1', 16:44:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:44:05 INFO - 'PWD': '/builds/slave/test-pgo', 16:44:05 INFO - 'SHELL': '/bin/bash', 16:44:05 INFO - 'SHLVL': '1', 16:44:05 INFO - 'TERM': 'linux', 16:44:05 INFO - 'TMOUT': '86400', 16:44:05 INFO - 'USER': 'cltbld', 16:44:05 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447719739.442651-1430312401', 16:44:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:05 INFO - '_': '/tools/buildbot/bin/python'} 16:44:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:44:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:44:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:44:07 INFO - Installing collected packages: mozsystemmonitor 16:44:07 INFO - Running setup.py install for mozsystemmonitor 16:44:07 INFO - Successfully installed mozsystemmonitor 16:44:07 INFO - Cleaning up... 16:44:07 INFO - Return code: 0 16:44:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:44:07 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')]} 16:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:07 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')]} 16:44:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:07 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 0x7fbcc1a39c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ec6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ad3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25368c0>, '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 0x24e3420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e38b0>, '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': '6587686cb2da90a5f91b3170000001be-1447719739.442651-1430312401', '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 16:44:07 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 16:44:07 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 16:44:07 INFO - Using env: {'DISPLAY': ':0', 16:44:07 INFO - 'HOME': '/home/cltbld', 16:44:07 INFO - 'LANG': 'en_US.UTF-8', 16:44:07 INFO - 'LANGUAGE': 'en_US:en', 16:44:07 INFO - 'LOGNAME': 'cltbld', 16:44:07 INFO - 'MAIL': '/var/mail/cltbld', 16:44:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:07 INFO - 'MOZ_NO_REMOTE': '1', 16:44:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:07 INFO - 'NO_EM_RESTART': '1', 16:44:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:44:07 INFO - 'PWD': '/builds/slave/test-pgo', 16:44:07 INFO - 'SHELL': '/bin/bash', 16:44:07 INFO - 'SHLVL': '1', 16:44:07 INFO - 'TERM': 'linux', 16:44:07 INFO - 'TMOUT': '86400', 16:44:07 INFO - 'USER': 'cltbld', 16:44:07 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447719739.442651-1430312401', 16:44:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:07 INFO - '_': '/tools/buildbot/bin/python'} 16:44:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:08 INFO - Downloading/unpacking blobuploader==1.2.4 16:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:09 INFO - Downloading blobuploader-1.2.4.tar.gz 16:44:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:44:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:44:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:44:09 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 16:44:09 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 16:44:09 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 16:44:09 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 16:44:09 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 16:44:09 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 16:44:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:44:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:44:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:10 INFO - Downloading docopt-0.6.1.tar.gz 16:44:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:44:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:44:10 INFO - Installing collected packages: blobuploader, requests, docopt 16:44:10 INFO - Running setup.py install for blobuploader 16:44:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:44:10 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:44:10 INFO - Running setup.py install for requests 16:44:10 INFO - Running setup.py install for docopt 16:44:11 INFO - Successfully installed blobuploader requests docopt 16:44:11 INFO - Cleaning up... 16:44:11 INFO - Return code: 0 16:44:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:44:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcc1a39c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ec6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ad3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25368c0>, '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 0x24e3420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e38b0>, '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': '6587686cb2da90a5f91b3170000001be-1447719739.442651-1430312401', '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 16:44:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 16:44:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:44:11 INFO - Using env: {'DISPLAY': ':0', 16:44:11 INFO - 'HOME': '/home/cltbld', 16:44:11 INFO - 'LANG': 'en_US.UTF-8', 16:44:11 INFO - 'LANGUAGE': 'en_US:en', 16:44:11 INFO - 'LOGNAME': 'cltbld', 16:44:11 INFO - 'MAIL': '/var/mail/cltbld', 16:44:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:11 INFO - 'MOZ_NO_REMOTE': '1', 16:44:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:11 INFO - 'NO_EM_RESTART': '1', 16:44:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:44:11 INFO - 'PWD': '/builds/slave/test-pgo', 16:44:11 INFO - 'SHELL': '/bin/bash', 16:44:11 INFO - 'SHLVL': '1', 16:44:11 INFO - 'TERM': 'linux', 16:44:11 INFO - 'TMOUT': '86400', 16:44:11 INFO - 'USER': 'cltbld', 16:44:11 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447719739.442651-1430312401', 16:44:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:11 INFO - '_': '/tools/buildbot/bin/python'} 16:44:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:44:11 INFO - Running setup.py (path:/tmp/pip-fYHdae-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:44:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:44:11 INFO - Running setup.py (path:/tmp/pip-d2_MhT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:44:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:44:11 INFO - Running setup.py (path:/tmp/pip-sMOP43-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:44:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:44:11 INFO - Running setup.py (path:/tmp/pip-K1MTKR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:44:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:44:11 INFO - Running setup.py (path:/tmp/pip-Aaelmi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:44:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:44:11 INFO - Running setup.py (path:/tmp/pip-5kG8ek-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:44:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:44:11 INFO - Running setup.py (path:/tmp/pip-DqV6z5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:44:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:44:11 INFO - Running setup.py (path:/tmp/pip-uRd_iu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:44:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:44:11 INFO - Running setup.py (path:/tmp/pip-Xb875H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:44:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:44:11 INFO - Running setup.py (path:/tmp/pip-9FcjSD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:44:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:44:11 INFO - Running setup.py (path:/tmp/pip-DXYVrC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:44:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:44:12 INFO - Running setup.py (path:/tmp/pip-uMrX6G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:44:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:44:12 INFO - Running setup.py (path:/tmp/pip-W8enDJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:44:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:44:12 INFO - Running setup.py (path:/tmp/pip-hzYbYo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:44:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:44:12 INFO - Running setup.py (path:/tmp/pip-H075Xw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:44:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:44:12 INFO - Running setup.py (path:/tmp/pip-8P_AFj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:44:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:44:12 INFO - Running setup.py (path:/tmp/pip-dmq6bd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:44:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:44:12 INFO - Running setup.py install for manifestparser 16:44:12 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:44:12 INFO - Running setup.py install for mozcrash 16:44:12 INFO - Running setup.py install for mozdebug 16:44:12 INFO - Running setup.py install for mozdevice 16:44:12 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:44:12 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:44:12 INFO - Running setup.py install for mozfile 16:44:12 INFO - Running setup.py install for mozhttpd 16:44:13 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:44:13 INFO - Running setup.py install for mozinfo 16:44:13 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:44:13 INFO - Running setup.py install for mozInstall 16:44:13 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:44:13 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:44:13 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:44:13 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:44:13 INFO - Running setup.py install for mozleak 16:44:13 INFO - Running setup.py install for mozlog 16:44:13 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:44:13 INFO - Running setup.py install for moznetwork 16:44:13 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:44:13 INFO - Running setup.py install for mozprocess 16:44:13 INFO - Running setup.py install for mozprofile 16:44:13 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:44:13 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:44:13 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:44:13 INFO - Running setup.py install for mozrunner 16:44:13 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:44:13 INFO - Running setup.py install for mozscreenshot 16:44:14 INFO - Running setup.py install for moztest 16:44:14 INFO - Running setup.py install for mozversion 16:44:14 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:44:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:44:14 INFO - Cleaning up... 16:44:14 INFO - Return code: 0 16:44:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:44:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcc1a39c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ec6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ad3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25368c0>, '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 0x24e3420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e38b0>, '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': '6587686cb2da90a5f91b3170000001be-1447719739.442651-1430312401', '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 16:44:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 16:44:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:44:14 INFO - Using env: {'DISPLAY': ':0', 16:44:14 INFO - 'HOME': '/home/cltbld', 16:44:14 INFO - 'LANG': 'en_US.UTF-8', 16:44:14 INFO - 'LANGUAGE': 'en_US:en', 16:44:14 INFO - 'LOGNAME': 'cltbld', 16:44:14 INFO - 'MAIL': '/var/mail/cltbld', 16:44:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:14 INFO - 'MOZ_NO_REMOTE': '1', 16:44:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:14 INFO - 'NO_EM_RESTART': '1', 16:44:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:44:14 INFO - 'PWD': '/builds/slave/test-pgo', 16:44:14 INFO - 'SHELL': '/bin/bash', 16:44:14 INFO - 'SHLVL': '1', 16:44:14 INFO - 'TERM': 'linux', 16:44:14 INFO - 'TMOUT': '86400', 16:44:14 INFO - 'USER': 'cltbld', 16:44:14 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447719739.442651-1430312401', 16:44:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:14 INFO - '_': '/tools/buildbot/bin/python'} 16:44:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:44:14 INFO - Running setup.py (path:/tmp/pip-4Or58u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:44:14 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)) 16:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:44:14 INFO - Running setup.py (path:/tmp/pip-sK13qH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:44:14 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)) 16:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:44:14 INFO - Running setup.py (path:/tmp/pip-N47gwh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:44:14 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)) 16:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:44:14 INFO - Running setup.py (path:/tmp/pip-qkMupy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:44:14 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)) 16:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:44:14 INFO - Running setup.py (path:/tmp/pip-0VwqjZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:44:14 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)) 16:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:44:14 INFO - Running setup.py (path:/tmp/pip-CRf8Av-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:44:14 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)) 16:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:44:14 INFO - Running setup.py (path:/tmp/pip-0h513w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:44:14 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)) 16:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:44:14 INFO - Running setup.py (path:/tmp/pip-_3rB6_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:44:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 16:44:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:44:15 INFO - Running setup.py (path:/tmp/pip-JnkCnS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:44:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 16:44:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:44:15 INFO - Running setup.py (path:/tmp/pip-mjiR7K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:44:15 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)) 16:44:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:44:15 INFO - Running setup.py (path:/tmp/pip-Cuwma0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:44:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 16:44:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:44:15 INFO - Running setup.py (path:/tmp/pip-Ikt1mv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:44:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 16:44:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:44:15 INFO - Running setup.py (path:/tmp/pip-ZNoL4o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:44:15 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)) 16:44:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:44:15 INFO - Running setup.py (path:/tmp/pip-8Z3cBI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:44:15 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)) 16:44:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:44:15 INFO - Running setup.py (path:/tmp/pip-yzBMGh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:44:15 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)) 16:44:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:44:15 INFO - Running setup.py (path:/tmp/pip-ewOoof-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:44:15 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)) 16:44:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:44:15 INFO - Running setup.py (path:/tmp/pip-EbQVgE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:44:15 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)) 16:44:15 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)) 16:44:15 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)) 16:44:15 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)) 16:44:15 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)) 16:44:15 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)) 16:44:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:44:15 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 16:44:15 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 16:44:15 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 16:44:15 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 16:44:15 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 16:44:15 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 16:44:17 INFO - Downloading blessings-1.5.1.tar.gz 16:44:17 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 16:44:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:44:17 INFO - Installing collected packages: blessings 16:44:17 INFO - Running setup.py install for blessings 16:44:17 INFO - Successfully installed blessings 16:44:17 INFO - Cleaning up... 16:44:17 INFO - Return code: 0 16:44:17 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:44:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:44:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:44:17 INFO - Reading from file tmpfile_stdout 16:44:17 INFO - Current package versions: 16:44:17 INFO - argparse == 1.2.1 16:44:17 INFO - blessings == 1.5.1 16:44:17 INFO - blobuploader == 1.2.4 16:44:17 INFO - docopt == 0.6.1 16:44:17 INFO - manifestparser == 1.1 16:44:17 INFO - mozInstall == 1.12 16:44:17 INFO - mozcrash == 0.16 16:44:17 INFO - mozdebug == 0.1 16:44:17 INFO - mozdevice == 0.47 16:44:17 INFO - mozfile == 1.2 16:44:17 INFO - mozhttpd == 0.7 16:44:17 INFO - mozinfo == 0.9 16:44:17 INFO - mozleak == 0.1 16:44:17 INFO - mozlog == 3.0 16:44:17 INFO - moznetwork == 0.27 16:44:17 INFO - mozprocess == 0.22 16:44:17 INFO - mozprofile == 0.27 16:44:17 INFO - mozrunner == 6.11 16:44:17 INFO - mozscreenshot == 0.1 16:44:17 INFO - mozsystemmonitor == 0.0 16:44:17 INFO - moztest == 0.7 16:44:17 INFO - mozversion == 1.4 16:44:17 INFO - psutil == 3.1.1 16:44:17 INFO - requests == 1.2.3 16:44:17 INFO - wsgiref == 0.1.2 16:44:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:44:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:17 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 0x7fbcc1a39c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ec6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ad3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25368c0>, '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 0x24e3420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e38b0>, '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': '6587686cb2da90a5f91b3170000001be-1447719739.442651-1430312401', '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 16:44:17 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 16:44:17 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 16:44:17 INFO - Using env: {'DISPLAY': ':0', 16:44:17 INFO - 'HOME': '/home/cltbld', 16:44:17 INFO - 'LANG': 'en_US.UTF-8', 16:44:17 INFO - 'LANGUAGE': 'en_US:en', 16:44:17 INFO - 'LOGNAME': 'cltbld', 16:44:17 INFO - 'MAIL': '/var/mail/cltbld', 16:44:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:17 INFO - 'MOZ_NO_REMOTE': '1', 16:44:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:17 INFO - 'NO_EM_RESTART': '1', 16:44:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:44:17 INFO - 'PWD': '/builds/slave/test-pgo', 16:44:17 INFO - 'SHELL': '/bin/bash', 16:44:17 INFO - 'SHLVL': '1', 16:44:17 INFO - 'TERM': 'linux', 16:44:17 INFO - 'TMOUT': '86400', 16:44:17 INFO - 'USER': 'cltbld', 16:44:17 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447719739.442651-1430312401', 16:44:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:17 INFO - '_': '/tools/buildbot/bin/python'} 16:44:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 16:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 16:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 16:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 16:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 16:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 16:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 16:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 16:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:44:18 INFO - Cleaning up... 16:44:18 INFO - Return code: 0 16:44:18 INFO - Running post-action listener: _resource_record_post_action 16:44:18 INFO - Running post-action listener: _start_resource_monitoring 16:44:18 INFO - Starting resource monitoring. 16:44:18 INFO - ##### 16:44:18 INFO - ##### Running install step. 16:44:18 INFO - ##### 16:44:18 INFO - Running pre-action listener: _resource_record_pre_action 16:44:18 INFO - Running main action method: install 16:44:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:44:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:44:18 INFO - Reading from file tmpfile_stdout 16:44:18 INFO - Detecting whether we're running mozinstall >=1.0... 16:44:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:44:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:44:18 INFO - Reading from file tmpfile_stdout 16:44:18 INFO - Output received: 16:44:18 INFO - Usage: mozinstall [options] installer 16:44:18 INFO - Options: 16:44:18 INFO - -h, --help show this help message and exit 16:44:18 INFO - -d DEST, --destination=DEST 16:44:18 INFO - Directory to install application into. [default: 16:44:18 INFO - "/builds/slave/test-pgo"] 16:44:18 INFO - --app=APP Application being installed. [default: firefox] 16:44:18 INFO - mkdir: /builds/slave/test-pgo/build/application 16:44:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 16:44:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 16:44:32 INFO - Reading from file tmpfile_stdout 16:44:32 INFO - Output received: 16:44:32 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:44:32 INFO - Running post-action listener: _resource_record_post_action 16:44:32 INFO - ##### 16:44:32 INFO - ##### Running run-tests step. 16:44:32 INFO - ##### 16:44:32 INFO - Running pre-action listener: _resource_record_pre_action 16:44:32 INFO - Running main action method: run_tests 16:44:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:44:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:44:32 INFO - Python 2.7.3 16:44:32 INFO - Return code: 0 16:44:32 INFO - grabbing minidump binary from tooltool 16:44:32 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')]} 16:44:32 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 0x25368c0>, '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 0x24e3420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e38b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:44:32 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 16:44:32 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 16:44:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:44:32 INFO - Return code: 0 16:44:32 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:44:32 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:44:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:44:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:44:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:44:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JgTPEMinQ_iadziymxeNyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 16:44:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JgTPEMinQ_iadziymxeNyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost 16:44:32 INFO - Using env: {'DISPLAY': ':0', 16:44:32 INFO - 'HOME': '/home/cltbld', 16:44:32 INFO - 'LANG': 'en_US.UTF-8', 16:44:32 INFO - 'LANGUAGE': 'en_US:en', 16:44:32 INFO - 'LOGNAME': 'cltbld', 16:44:32 INFO - 'MAIL': '/var/mail/cltbld', 16:44:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:44:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:32 INFO - 'MOZ_NO_REMOTE': '1', 16:44:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:44:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:32 INFO - 'NO_EM_RESTART': '1', 16:44:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:44:32 INFO - 'PWD': '/builds/slave/test-pgo', 16:44:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:44:32 INFO - 'SHELL': '/bin/bash', 16:44:32 INFO - 'SHLVL': '1', 16:44:32 INFO - 'TERM': 'linux', 16:44:32 INFO - 'TMOUT': '86400', 16:44:32 INFO - 'USER': 'cltbld', 16:44:32 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447719739.442651-1430312401', 16:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:32 INFO - '_': '/tools/buildbot/bin/python'} 16:44:32 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JgTPEMinQ_iadziymxeNyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost'] with output_timeout 3600 16:44:32 INFO - mozversion INFO | application_buildid: 20151116143020 16:44:32 INFO - mozversion INFO | application_changeset: 2feb5677ea5cedb035700076148065deb08fb3aa 16:44:32 INFO - mozversion INFO | application_display_name: Nightly 16:44:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:44:33 INFO - mozversion INFO | application_name: Firefox 16:44:33 INFO - mozversion INFO | application_remotingname: firefox 16:44:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 16:44:33 INFO - mozversion INFO | application_vendor: Mozilla 16:44:33 INFO - mozversion INFO | application_version: 45.0a1 16:44:33 INFO - mozversion INFO | platform_buildid: 20151116143020 16:44:33 INFO - mozversion INFO | platform_changeset: 2feb5677ea5cedb035700076148065deb08fb3aa 16:44:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 16:44:33 INFO - mozversion INFO | platform_version: 45.0a1 16:44:33 INFO - 2015-11-16 16:44:32,999 DEBUG : using testdate: 1447721072 16:44:33 INFO - 2015-11-16 16:44:32,999 DEBUG : actual date: 1447721072 16:44:33 INFO - 2015-11-16 16:44:33,008 INFO : starting webserver on 'localhost:50272' 16:44:33 INFO - 2015-11-16 16:44:33,009 INFO : Starting test suite talos-linux64-ix-017.e 16:44:33 INFO - 2015-11-16 16:44:33,010 INFO : Starting test dromaeo_css 16:44:33 INFO - 2015-11-16 16:44:33,010 DEBUG : operating with platform_type : linux_ 16:44:33 INFO - 2015-11-16 16:44:33,010 INFO : Initialising browser for dromaeo_css test... 16:44:33 INFO - 2015-11-16 16:44:33,027 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphxbA9D/profile http://localhost:50272/getInfo.html 16:44:38 INFO - 2015-11-16 16:44:38,107 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:44:38 INFO - 2015-11-16 16:44:38,107 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:44:38 INFO - 2015-11-16 16:44:38,107 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:44:38 INFO - 2015-11-16 16:44:38,107 DEBUG : BROWSER_OUTPUT: __metrics 16:44:39 INFO - 2015-11-16 16:44:39,189 INFO : Browser initialized. 16:44:39 INFO - 2015-11-16 16:44:39,190 INFO : Running cycle 1/1 for dromaeo_css test... 16:44:39 INFO - 2015-11-16 16:44:39,190 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphxbA9D/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:44:50 INFO - 2015-11-16 16:44:50,981 DEBUG : BROWSER_OUTPUT: RSS: Main: 141418496 16:44:50 INFO - 2015-11-16 16:44:50,982 DEBUG : BROWSER_OUTPUT: 16:45:40 INFO - 2015-11-16 16:45:40,619 DEBUG : BROWSER_OUTPUT: 1447721140617 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] 16:47:49 INFO - 2015-11-16 16:47:49,372 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50272/tests/dromaeo/cssquery-ext.html) 16:47:50 INFO - 2015-11-16 16:47:50,375 DEBUG : BROWSER_OUTPUT: RSS: Main: 147873792 16:47:50 INFO - 2015-11-16 16:47:50,376 DEBUG : BROWSER_OUTPUT: 16:50:52 INFO - 2015-11-16 16:50:52,377 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50272/tests/dromaeo/cssquery-ext.html (next: http://localhost:50272/tests/dromaeo/cssquery-jquery.html) 16:50:52 INFO - 2015-11-16 16:50:52,962 DEBUG : BROWSER_OUTPUT: RSS: Main: 141389824 16:50:52 INFO - 2015-11-16 16:50:52,962 DEBUG : BROWSER_OUTPUT: 16:53:54 INFO - 2015-11-16 16:53:54,620 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50272/tests/dromaeo/cssquery-mootools.html) 16:53:55 INFO - 2015-11-16 16:53:55,205 DEBUG : BROWSER_OUTPUT: RSS: Main: 142872576 16:53:55 INFO - 2015-11-16 16:53:55,206 DEBUG : BROWSER_OUTPUT: 16:56:56 INFO - 2015-11-16 16:56:56,876 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50272/tests/dromaeo/cssquery-prototype.html) 16:56:57 INFO - 2015-11-16 16:56:57,463 DEBUG : BROWSER_OUTPUT: RSS: Main: 141074432 16:56:57 INFO - 2015-11-16 16:56:57,463 DEBUG : BROWSER_OUTPUT: 16:59:59 INFO - 2015-11-16 16:59:59,760 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50272/tests/dromaeo/cssquery-yui.html) 17:00:00 INFO - 2015-11-16 17:00:00,369 DEBUG : BROWSER_OUTPUT: RSS: Main: 140804096 17:00:00 INFO - 2015-11-16 17:00:00,369 DEBUG : BROWSER_OUTPUT: 17:03:02 INFO - 2015-11-16 17:03:02,783 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50272/tests/dromaeo/cssquery-yui.html (next: http://localhost:50272/tests/dromaeo/cssquery-dojo.html) 17:03:03 INFO - 2015-11-16 17:03:03,033 DEBUG : BROWSER_OUTPUT: RSS: Main: 143659008 17:03:03 INFO - 2015-11-16 17:03:03,034 DEBUG : BROWSER_OUTPUT: 17:03:03 INFO - 2015-11-16 17:03:03,035 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:03:03 INFO - 2015-11-16 17:03:03,035 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:03:03 INFO - 2015-11-16 17:03:03,035 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:03:03 INFO - 2015-11-16 17:03:03,035 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:03:03 INFO - 2015-11-16 17:03:03,037 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3246.513023046543;3266.7876588021777;3300.7029367356963;3307.421201289774;3313.353895990283;5375.946240537593;5527.557795376375;5542.0855558832745;5551.195076713879;5556.305461817273;5495.477929596682;5568.86077848054;5612.831615051545;5622.184783206432;5650.0959846424585;5028.7485625718655;5090.77091530882;5140.563052140573;5183.041137389595;5196.92204616931;5031.974840125794;5064.088464076464;5064.164412871872;5073.492650734934;5095.515925987025;4621.145088158668;4850.6362022848425;4943.233798761198;5105.132127538309;5107.157319042353;4992.600591952635;5004.599632029429;5015.749212539395;5023.271625614266;5071.416787069497;5000.549950504435;5025.0954828130925;5040.1179793535985;5048.040872234264;5066.138756411382;5259.605529585297;5306.575473962073;5353.518183363477;5379.784808607651;5410.783568657249;6050.2134722486235;6113.449789518964;6135.539834512385;6140.0789881517685;6149.29283132441;5886.6468011919;6168.475679567242;6173.074038894157;6178.135061091406;6182.96908515459;5492.258545096401;5647.604667673265;5727.885442291131;5745.224394706703;5780.219670344533;5999.070144127667;6008.3390827009;6010.729517171738;6010.939890601126;6027.336992930862;5782.739776710058;5866.911996319973;5882.55880808941;5885.3820348862755;5893.793717219876;5919.852003699856;5956.583039187215;5972.343042265347;5981.641101533834;6012.819615411545;6042.3655516170165;6057.454829065406;6066.393360663987;6068.302145253352;6078.908816367758;5754.88490230193;5864.560157988082;5875.529957603467;5990.970045149834;6001.939980600138;4616.584507394351;4623.768811559408;4633.536646335407;4638.628909687217;4639.095376401569;4085.9182816343505;4098.323776576891;4116.75299482026;4124.298869192245;4155.397467367215;5475.616706830484;5569.66582005081;5632.3804381518;5742.196092547047;5811.27359080115;6038.879222415615;6053.697315134225;6076.0885867119405;6080.969595151996;6084.969575152096;5707.828765137053;5727.083666613322;5741.971290143522;5755.740991655385;5763;4995.600351971906;5083.262926875583;5102.36220472441;5192.324997750268;5209.6353255272525;6232.688365581703;6266.843328916722;6282.874342513124;6285.96857015712;6287.056941458726;5826.504747096545;6070.2108725865355;6073.271207454957;6095.51235901118;6102.725377358119;6060.212172417558;6106.877862442638;6163.8150855474405;6204;6227;5960.940390596039;6006.039033754753;6007.729652165575;6011.188489553854;6020.729067191899;5775.451332123442;5861;6049.848753781191;6080.452759251689;6082.787102451393;5755.5683323750045;5758.481736643722;5848.181254624271;5860.765569377178;5897.144913987362;5835.183074369676;5930.229070220844;5930.377310382521;5964.850878727893;5965.940340596539;5628.577856660685;5699.971500142473;5785.595008349375;5820.214271073351;5830.300363956352;5914.4381283777975;5968.343482217039;5971.880562388641;5974.581779275582;5987.550933679904;5782.942170578409;5799.4780469757925;5811.738471768866;5813.82558523245;5818.2436283282905 17:03:03 INFO - 2015-11-16 17:03:03,038 DEBUG : BROWSER_OUTPUT: |1;ext.html;558.9659130608372;574.7212601888085;613.2365205319377;613.7943788830742;675.4967549175861;31156.22109447262;32109.678903210992;40369.39445908314;40818.59181408185;40929.590704093025;42894;43425.34861977073;43548.12903741923;43625.34561981573;43652.345214821726;8645.265152462049;8734.912650873504;8760.12398760122;8813.64745410186;8823.2941364691;8525.317974562051;8622.913770862273;8641.481511109321;8642.265407440374;8650.26472749814;8657.523836189008;8724.52015139167;8752.081031491698;8776;8779.473231606124;8621.65513379464;8679.479231246114;8695.652173913037;8711.695090671828;8716.825663486758;8537.317014638815;8622.913770862273;8672.739817805475;8679.262262707678;8680.696175633886;39455.21089578192;39685;39686.60313396887;39924;39949.20101597952;3293.4730443129224;3313.9834300828584;3352.379809735207;3386.7121294689737;3888.5333759948985;29202.853985729937;29501.852490737623;29952.25119372033;30545.541816872767;30634.387312253853;3509.78941263525;3533.808023963425;3534.929301413983;3621.7102631789394;3673.522442082512;266277;267126;267132;268700;270562.47187640733;56104.43895560992;56203.71898140483;56597.71701141468;57350;58254;54124;54174.45825541694;54193.45806541963;54377;54509.72745136249;15034.548963531111;15143.621409464631;15308.081515109128;15314.923425382802;15346.23268836576;10826.40454774995;10899.564017439214;10989.395583242838;10990.615328463466;10992.230543861853;18837;18842.528936776416;18863.90568047151;18914.243430262635;18959.62080758377;7249.637518124073;7341.229170937081;7404.296591823768;7461.403087752967;7469.551826890404;935.1209862729013;983.6508039645822;988.8170688422665;997.4414327976357;1036.5594622285648;28649.71350286512;28882;29100.563491547644;29303.85348073246;29375.412491750045;1084.3602274657833;1119.339589642115;1127.115214556569;1191.065013964034;1208.0878936403135;14954.40182392692;15104;15411.22943852803;15435.151066691215;15457.432149062495;312858;314060;314159;314799;316076;52356.214656780176;52469.212961805606;52514.737426312626;52565.47434525682;52745;1333.3666508408621;1363.3319673359783;1365.6312795545148;1366.719822436398;1370.0067451098073;27894;28554.42891142207;28925.276868078465;29065.564016540193;29343.266418339714;47693.52306476891;48616.270755937985;48834.26748598703;48900.5109948896;49072.263916040574;272361;273205;275395;276114;276971;31078.68921310758;31492.370152596362;31695.207619809687;31906.840465797522;32384.676153238164;38257;38408.61591384162;38491.61508384992;38994.80502597469;39262.4110638335;33322.66677333292;34545.30909381748;35902.820485898446;35997.64002359943;36166.27667446689;33060.834695826365;34519;34588.65411345854;35589.644103559665;36228.63771362253;32602.34795304128;32874.342513149124;33066.66933330636;33373.499397508574;35393.64606353903;27863.24363132274;29198.124056278346;30755.84622076875;31032;31047.84476077605;25109.372265693502;25233.74766252314;25417.237482875542;25747.485050299263;25875.61186582165 17:03:03 INFO - 2015-11-16 17:03:03,039 DEBUG : BROWSER_OUTPUT: |2;jquery.html;348.81861432055314;349.5368636556563;350.08103727714746;353.3498363012058;353.47508949210436;12350.752984940296;12843.614691559245;16554.17229138543;17743.37898173564;18823.71764423535;11846.644600661972;11898.64304070877;11900.642980710592;12053.39733013348;12293.569725059602;4417.0944956283965;4522.1181869535285;4552.112338094073;4563.315502674593;4566.748828814414;4729;4865.48912364202;4875.341828853113;4877.829275975341;4879.097366987119;3517.8416971236356;3568.3220188164164;4801.135795556798;4802.03959208158;4816.879578010543;4935.23503856901;5020.297158397827;5056.6713163644245;5059.089363914494;5078.873028174288;4276.743395396286;4332.501762297345;4348.043430445297;4349.151915376503;4361.040571074359;13309.933450332686;13502.122362046533;13543.525976590772;13675.384607692678;13688;1919.251491918153;1993.6311782320317;2055.126571207231;2073.1085633177727;2134.018351558285;9860.506974651238;10078.244131690153;10085.596576136946;10301.690949271533;10348.94825525875;1681.7477378393216;1687.822778608253;1703.8722095842738;1740.8955462672154;1781.1628534588722;58691.906225636376;61405.07892381618;62482.37517624811;62879;62901.68549157225;6897.103376561015;6981.05755722981;7045.577265364094;7059.82350441243;7131.928680713127;8407.74776756686;8422.441848258091;8467.407281490237;8485.32117430604;8501.107383724744;5549.19536667181;5550.528205102531;5551.916721249185;5580.2745643066955;5596.664200147923;5554.527865131509;5559.916601250984;5564.610477266633;5638.126090455986;5725.112607545837;3263.233140212048;3274.6070471543567;3304.5208444775853;3307.255867429809;3313.801171929692;1175.1127898436625;1179.3395698408747;1182.491528642692;1186.9525218991316;1223.5411720604773;463.08771719712115;464.7792298658178;474.563401670464;475.2040332443144;493.85431297767246;10601.73495662599;10989.670309890716;11668.416579171007;11826.704332391759;12513.124081314403;503.40849501835197;511.4246472718192;519.0086933956126;525.6425630571172;527.4330095147654;6387.648679322589;6538.476921846241;6614.206295244505;6635.734570617218;6707.5975441473665;481867;493024;501032;503342;506982;77499.61250193712;79434.20565794384;80150;80974;81505;569.5728203847115;571.725571725574;576.9163471296639;578.7453520451072;580.8344621782857;11036.834447483454;11271.605493808005;11279.436028198721;11312.490937907649;11479.770404591694;35596.466053008706;35975.64024359723;36056;37497.62502374942;37565.624343756215;48431.27353089777;48578.757106214245;50077.49922500728;50534;50610;6781.38967492928;6797.422219111233;6915.343042410963;6915.89626155598;6928.965355173192;12042.157049006835;12270.81593776112;12291.508339666314;12435.253884766942;12632.178908370926;9099.909000910171;10925.726856828325;11143.498542565441;11155.83266251023;11161.33032018049;9694.418334899929;9720.319577629498;9751.171150452292;9825.705228843146;10239.18086553059;9691.70924872255;9759.9024009759;9933.056359645821;10188.490575471345;10198;14446.855531444551;14547.399786023741;14789.852101478848;14927.850721492647;15066.171360575274;15740.134292614017;15902.68194636124;16006.519804405887;16195.919020404823;16357.936734112245 17:03:03 INFO - 2015-11-16 17:03:03,039 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1420.6448387903024;1619.2146808797731;1671.4066506390232;1675.1540472061606;1687.7637130801681;7276.781696549098;7331.780046598597;7417.184109747924;7427.628618569077;7461.664225109869;7820.139784623701;7899.170587088359;7911.208879112086;7917.366610671147;7957.681692732298;2267.5804976079435;2289.5077558324956;2293.919712810052;2308.226744040748;2308.480591866825;2260.559190957764;2272.7045484087043;2347.835651504395;2348.1546643208517;2348.3542025942834;2111.398251498323;2155.245664017589;2222.3333000099988;2230.163688616769;2261.796438320551;2319.0491898321693;2343.6836027136287;2348.1077190667606;2358.7759162879497;2362.3857796972825;2277.3737222263844;2302.988485057564;2330.8951097200666;2334.0897050150456;2335.065973610552;7668.884966725448;7706.537607743553;7730.458867879251;7745.496542724705;7758.883616745753;4649.628029757645;4707.340972263886;4727.5272472752795;4728.95271047292;4758.571728544448;2895.5077636801793;2976.866041028159;3020.1845501714415;3031.711987361219;3037.3621539476735;883.9602217900145;916.757059379265;938.029139840262;956.8277710012195;966.1980556138388;10194.184465242763;10361.63734269297;10365.118964887994;10365.844512332396;10379.532921018572;4101.8974525637095;4122.40225167349;4152.896177595524;4162.438070860395;4225.464721167336;8612.65549378018;8624.051354351017;8650.09174036717;8659.653613855502;8669.956650216709;4461.553844615512;4462.531434199363;4464.2187617166865;4468.419105516262;4471.977640111843;4090.1206240658403;4100.5489396166395;4108.938365924513;4158.812853421603;4160.54234034256;3485.9651403486146;3488.075659950115;3503.7547371683736;3522.8238588070494;3549.5208146900354;1038.7610849504656;1039.3036665434176;1041.9270651054505;1043.5564884923876;1059.2426415113232;971.3103696375512;972.4700038479045;1106.773111512138;1169.7485040716288;1290.4838064774165;7015;7185.317394847481;7205.7838264852135;7209.783706488814;7210.819729506699;1115.5593540551438;1122.5565901469038;1128.1257025805066;1140.7262257058412;1142.5544037825255;5429.701366424884;5457.345118585716;5502.367227768777;5502.697351645698;5543.52880005196;8887.822243555092;9115.225205857443;9201.309901757395;9261.44431334122;9400.24798016157;9196.264298856075;9197.95401023004;9211.815763684823;9244.8613270801;9312.348135630577;7112.822179445452;7153.821154471076;7209.170945341353;7243.637818109073;7259.092613423322;6960.4779641526075;7003.26465721092;7011.6494175292055;7016.19313778922;7023.929760702327;7959.681612735426;8110.270075693216;8203.671853126047;8236.052853921876;8315.792105197177;8321.750347489586;8408.621612027597;8444.944381952257;8461.153884611736;8504.787380315542;6478.611283323015;6479.7247162755475;6482.092507048923;6486.091947127312;6504;7341.963290183515;7349.522281051714;7371.041764570571;7392.815179620553;7440.2931721486375;6783.084283621648;6785.830354241183;7068.222495525591;7140.642967851691;7192.244814294424;6546.443552298108;6702.966485167543;6744.8651026978205;6776.86446271062;6839.487038472035;6840.657967101525;6886.931130688629;6929.272426395358;6946.2011868635755;6978.546394484342;6259.405356491126;6281.277653069956;6299.433051025429;6307.621542707452;6352;6034.487068599218;6097.2683278006925;6103.42017508336;6357.809265722036;6454.5159113065765 17:03:03 INFO - 2015-11-16 17:03:03,041 DEBUG : BROWSER_OUTPUT: |4;prototype.html;315.65908818476044;320.4728222074686;321.4583426925632;325.40288570473183;325.8077734136859;6343.429091381775;6385.680715964207;6445.613263204205;6479;6549.869002619945;6366.936330636692;6381.840453988652;6406;6410.935890641093;6422.614643121416;4630.606398456135;4753.33453316536;4770.189067858472;4773.57037866592;4791;4749.073930583538;4763.571278584926;4767.11808315461;4770.856874293777;4797.544233297831;4689.320048592969;4695.413073365829;4697.88255293617;4708.505606911276;4716.599089077433;4716.97641511792;4723.36234608327;4725.10223057618;4725.173094708447;4738.549837765407;3965.167314863882;4072.0023594219606;4073.5111786585503;4075.1645912587846;4090.550039495653;6002.459778619901;6013.458788709037;6026.608270462406;6040.154378387029;6042.909356359658;5479.589030822664;5482.122860342366;5510.504054635102;5519.917201241985;5522.144067669517;6604.3725846044545;6698.665066746643;6713.060171575983;6717.932820671779;6741.460683145337;4499.055198408339;4505.5719706627815;4507.3689683444345;4507.977460112711;4508.053308805155;6898.172219333662;6966.442684585221;6969.58182509051;6979.546329488567;6982.825429364307;4559.863204103815;4565;4572.5198854119835;4576.313552967015;4582.725036497754;4495.505494395614;4552.954470455319;4631.745254011062;4631.814727410933;4639.652026098056;5406.2701535292235;5411.783528658888;5414.6480478769545;5417.133258678671;5434.375046869582;6781.966090169616;6787.083743694637;6790.898136527956;6791.151106111736;6795.218549866829;1642.8603568696794;1649.2083799775935;1650.488348611934;1654.5780825889562;1654.710425675502;1044.8798388185455;1051.9368837869752;1061.5541472581535;1063.1813503602184;1074.0119090436817;6517.446017088506;6521.739130434825;6524.575902566318;6562.179727534059;6660.83347916306;7024.789256322319;7073.929260707327;7083;7101;7101.183363913216;6611.20665520131;6627.204735431779;6635.270120286765;6639.170103737033;6644.867102658017;3759.0978165240144;3814.675752561008;3838.3858582626644;3843.442700808367;3871.593482684334;7326.194118646945;7372.889406658905;7375.9673645689645;7383.630818459055;7389.630518474162;7243.529170603999;7254.093238345207;7267.30960558746;7299.598522081336;7309.744158954411;7173.605451700102;7320.487565870444;7356.889646655304;7398.223186565441;7434.516756410816;7082.929170708227;7096.148462184365;7100.857982840417;7108.2536333686285;7109.253528379446;6859.691313890987;6960.686769095504;7011.474139439664;7030.683619237045;7034.859302814018;7339.376153026839;7356.926430735838;7377.372923301579;7397.926020739724;7409.962950185214;4514.751688657024;4535.183666939983;4546.249868771748;4552.590266875997;4583.0604726030415;6774.085498457645;6960.965195173992;6962.164540254999;6965.164180298397;6972.9302706972285;6813.8977915330315;6817.761378351734;6819.4544436443975;6824.658767061528;6829.214640316427;6827.931720682928;6829.760958366433;6829.931700683128;6836;6838.2136054352395;6454.806355809334;6632.303608121078;6648.601083934979;6654.800355989328;6676.899846502403;6764.763233286812;6794.184697836291;6839.589624622538;6872.518923675495;6882.793516194522;6698.5980841149685;6723.2940541244425;6731.596104233761;6742.831429214113;6763.7632682855865 17:03:03 INFO - 2015-11-16 17:03:03,042 DEBUG : BROWSER_OUTPUT: |5;yui.html;751.939844812415;774.8798936164897;785.5993443343895;847.953362565059;858.7080392666496;14275.571732848031;14287.499937502189;14412.06321589096;14469.782953255683;14479.782803257945;13441.26073065981;13510.189388636689;13521.59435216945;13534.729305413886;13540.458381664746;668.5019660353043;678.4368973751799;808.6320724070563;815.0586073085581;826.0747962282252;819.3895547816885;820.3314298846451;821.5563595658338;830.8961379827522;831.5592735849979;858.8969323681135;871.9754288710772;873.2839071960994;874.2306770042354;874.4622057434696;855.9529225892542;860.8923884514436;861.4745005546612;862.7886167888845;863.7020228021322;638.7157714816908;644.3395519592408;645.106527459472;645.6932956845508;646.0309535696455;12135.211211271238;12201;12261.203021803643;12280.631581052583;12322.507099716;12407.379631018503;13246;13274.800877986838;13362.331883405888;13442.193468391928;10272.435016074112;10373.325733827278;10442.2168337375;10448.68653940383;10474.738131546696;3338.0820274424486;3369.6461871503384;3405.455127179664;3487.19794447276;3498.2303893143467;45375.77312113418;45677.858053548596;45792.77103614527;45927;45942.310865337044;5617.157426385993;5717.313922329347;5729.341125770507;5833.183354330312;5936.228290322317;9098.272138228926;9164.450132992042;9198.862017069749;9221.308401869886;9240.722778316662;6983.336583024605;7061.752838650726;7097.751578694721;7102.325279098477;7283.562986220843;4316.7963522822765;4324.762138082436;4348.913021739548;4366.628836548865;4394.714343567658;2806.9859650701615;2819.746222839954;2821.4498172856097;2823.8729257183477;2826.23691603266;452.1228816096762;454.06462686865166;461.52462963148014;462.09660114476117;470.98351557695315;681.3867519232631;689.6791946776257;707.5754547271699;708.8334241453255;752.1688534169773;8890.511021893728;9383;9887.209023278265;10019.899801002042;10062.127905701167;691.3604915453186;707.264444977218;718.6765955320127;724.9565026098451;747.8130467383154;4000.179963107556;4280.978595107004;4313.805878735402;4416.205083085011;4475.888102797391;62314.0652890207;62824;63245;63351.683241583494;63555.6822215886;53208.20187697188;53895.19157212645;54260.45739542554;54436.455635443934;54495.45504544904;48676.7566162174;48841.75579122153;48894.51105488899;49238.75380623074;49968.50031499711;8611.827763444571;8921.955390223267;8960.820783584162;8993.14565116313;9016.18854303116;34803.477947830295;34973.82513087418;35564.28871422609;35593.82203088968;36025.45961810627;47273.29090063583;47978.76010619925;48038.59807009566;48202;48491.5150848487;7527.2096429876265;7577.431692622965;8088.988876390451;8297.669401595052;8326.45878017927;10254.948725256625;10568.577256909637;10642.73393165146;10695.625653102104;10719.678409647722;11056.778864422828;11190.104791616814;11226.158038147334;11295.322280663186;11606.419679016184;10808.89191108079;10836.67489975302;11082.556697732323;11387.943060284646;11510.82733759011;10554.525046372779;10955.616553420592;11859.229150105215;12217.69455763613;12217.816732748837;9244.861327079965;9287.442753434816;9307.86038209441;9378.296627752808;9900.356476828983;8593.828123437372;8943;9065.637374504946;9516.47659378713;9729.221662267144 17:03:03 INFO - 2015-11-16 17:03:03,042 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:03:03 INFO - 2015-11-16 17:03:03,042 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:03:03 INFO - 2015-11-16 17:03:03,042 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,296 17:03:03 INFO - 2015-11-16 17:03:03,042 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:03:03 INFO - 2015-11-16 17:03:03,042 DEBUG : BROWSER_OUTPUT: __startTimestamp1447722183034__endTimestamp 17:03:03 INFO - 2015-11-16 17:03:03,043 DEBUG : BROWSER_OUTPUT: 17:03:03 INFO - 2015-11-16 17:03:03,043 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:03:03 INFO - 2015-11-16 17:03:03,043 DEBUG : BROWSER_OUTPUT: Number of tests: 6 17:03:03 INFO - 2015-11-16 17:03:03,043 DEBUG : BROWSER_OUTPUT: 17:03:03 INFO - 2015-11-16 17:03:03,043 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5564.78 Median:5785.60 stddev:643.45 (11.1%) stddev-sans-first:619.19 17:03:03 INFO - 2015-11-16 17:03:03,043 DEBUG : BROWSER_OUTPUT: Values: 3246.5 3266.8 3300.7 3307.4 3313.4 5375.9 5527.6 5542.1 5551.2 5556.3 5495.5 5568.9 5612.8 5622.2 5650.1 5028.7 5090.8 5140.6 5183.0 5196.9 5032.0 5064.1 5064.2 5073.5 5095.5 4621.1 4850.6 4943.2 5105.1 5107.2 4992.6 5004.6 5015.7 5023.3 5071.4 5000.5 5025.1 5040.1 5048.0 5066.1 5259.6 5306.6 5353.5 5379.8 5410.8 6050.2 6113.4 6135.5 6140.1 6149.3 5886.6 6168.5 6173.1 6178.1 6183.0 5492.3 5647.6 5727.9 5745.2 5780.2 5999.1 6008.3 6010.7 6010.9 6027.3 5782.7 5866.9 5882.6 5885.4 5893.8 5919.9 5956.6 5972.3 5981.6 6012.8 6042.4 6057.5 6066.4 6068.3 6078.9 5754.9 5864.6 5875.5 5991.0 6001.9 4616.6 4623.8 4633.5 4638.6 4639.1 4085.9 4098.3 4116.8 4124.3 4155.4 5475.6 5569.7 5632.4 5742.2 5811.3 6038.9 6053.7 6076.1 6081.0 6085.0 5707.8 5727.1 5742.0 5755.7 5763.0 4995.6 5083.3 5102.4 5192.3 5209.6 6232.7 6266.8 6282.9 6286.0 6287.1 5826.5 6070.2 6073.3 6095.5 6102.7 6060.2 6106.9 6163.8 6204.0 6227.0 5960.9 6006.0 6007.7 6011.2 6020.7 5775.5 5861.0 6049.8 6080.5 6082.8 5755.6 5758.5 5848.2 5860.8 5897.1 5835.2 5930.2 5930.4 5964.9 5965.9 5628.6 5700.0 5785.6 5820.2 5830.3 5914.4 5968.3 5971.9 5974.6 5987.6 5782.9 5799.5 5811.7 5813.8 5818.2 17:03:03 INFO - 2015-11-16 17:03:03,043 DEBUG : BROWSER_OUTPUT: 17:03:03 INFO - 2015-11-16 17:03:03,043 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45252.39 Median:19049.22 stddev:74783.70 (392.6%) stddev-sans-first:74918.20 17:03:03 INFO - 2015-11-16 17:03:03,043 DEBUG : BROWSER_OUTPUT: Values: 559.0 574.7 613.2 613.8 675.5 31156.2 32109.7 40369.4 40818.6 40929.6 42894.0 43425.3 43548.1 43625.3 43652.3 8645.3 8734.9 8760.1 8813.6 8823.3 8525.3 8622.9 8641.5 8642.3 8650.3 8657.5 8724.5 8752.1 8776.0 8779.5 8621.7 8679.5 8695.7 8711.7 8716.8 8537.3 8622.9 8672.7 8679.3 8680.7 39455.2 39685.0 39686.6 39924.0 39949.2 3293.5 3314.0 3352.4 3386.7 3888.5 29202.9 29501.9 29952.3 30545.5 30634.4 3509.8 3533.8 3534.9 3621.7 3673.5 266277.0 267126.0 267132.0 268700.0 270562.5 56104.4 56203.7 56597.7 57350.0 58254.0 54124.0 54174.5 54193.5 54377.0 54509.7 15034.5 15143.6 15308.1 15314.9 15346.2 10826.4 10899.6 10989.4 10990.6 10992.2 18837.0 18842.5 18863.9 18914.2 18959.6 7249.6 7341.2 7404.3 7461.4 7469.6 935.1 983.7 988.8 997.4 1036.6 28649.7 28882.0 29100.6 29303.9 29375.4 1084.4 1119.3 1127.1 1191.1 1208.1 14954.4 15104.0 15411.2 15435.2 15457.4 312858.0 314060.0 314159.0 314799.0 316076.0 52356.2 52469.2 52514.7 52565.5 52745.0 1333.4 1363.3 1365.6 1366.7 1370.0 27894.0 28554.4 28925.3 29065.6 29343.3 47693.5 48616.3 48834.3 48900.5 49072.3 272361.0 273205.0 275395.0 276114.0 276971.0 31078.7 31492.4 31695.2 31906.8 32384.7 38257.0 38408.6 38491.6 38994.8 39262.4 33322.7 34545.3 35902.8 35997.6 36166.3 33060.8 34519.0 34588.7 35589.6 36228.6 32602.3 32874.3 33066.7 33373.5 35393.6 27863.2 29198.1 30755.8 31032.0 31047.8 25109.4 25233.7 25417.2 25747.5 25875.6 17:03:03 INFO - 2015-11-16 17:03:03,043 DEBUG : BROWSER_OUTPUT: 17:03:03 INFO - 2015-11-16 17:03:03,044 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26279.75 Median:4557.71 stddev:81664.25 (1791.8%) stddev-sans-first:81870.13 17:03:03 INFO - 2015-11-16 17:03:03,044 DEBUG : BROWSER_OUTPUT: Values: 348.8 349.5 350.1 353.3 353.5 12350.8 12843.6 16554.2 17743.4 18823.7 11846.6 11898.6 11900.6 12053.4 12293.6 4417.1 4522.1 4552.1 4563.3 4566.7 4729.0 4865.5 4875.3 4877.8 4879.1 3517.8 3568.3 4801.1 4802.0 4816.9 4935.2 5020.3 5056.7 5059.1 5078.9 4276.7 4332.5 4348.0 4349.2 4361.0 13309.9 13502.1 13543.5 13675.4 13688.0 1919.3 1993.6 2055.1 2073.1 2134.0 9860.5 10078.2 10085.6 10301.7 10348.9 1681.7 1687.8 1703.9 1740.9 1781.2 58691.9 61405.1 62482.4 62879.0 62901.7 6897.1 6981.1 7045.6 7059.8 7131.9 8407.7 8422.4 8467.4 8485.3 8501.1 5549.2 5550.5 5551.9 5580.3 5596.7 5554.5 5559.9 5564.6 5638.1 5725.1 3263.2 3274.6 3304.5 3307.3 3313.8 1175.1 1179.3 1182.5 1187.0 1223.5 463.1 464.8 474.6 475.2 493.9 10601.7 10989.7 11668.4 11826.7 12513.1 503.4 511.4 519.0 525.6 527.4 6387.6 6538.5 6614.2 6635.7 6707.6 481867.0 493024.0 501032.0 503342.0 506982.0 77499.6 79434.2 80150.0 80974.0 81505.0 569.6 571.7 576.9 578.7 580.8 11036.8 11271.6 11279.4 11312.5 11479.8 35596.5 35975.6 36056.0 37497.6 37565.6 48431.3 48578.8 50077.5 50534.0 50610.0 6781.4 6797.4 6915.3 6915.9 6929.0 12042.2 12270.8 12291.5 12435.3 12632.2 9099.9 10925.7 11143.5 11155.8 11161.3 9694.4 9720.3 9751.2 9825.7 10239.2 9691.7 9759.9 9933.1 10188.5 10198.0 14446.9 14547.4 14789.9 14927.9 15066.2 15740.1 15902.7 16006.5 16195.9 16357.9 17:03:03 INFO - 2015-11-16 17:03:03,044 DEBUG : BROWSER_OUTPUT: 17:03:03 INFO - 2015-11-16 17:03:03,044 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5335.87 Median:6354.90 stddev:2748.31 (43.2%) stddev-sans-first:2740.26 17:03:03 INFO - 2015-11-16 17:03:03,045 DEBUG : BROWSER_OUTPUT: Values: 1420.6 1619.2 1671.4 1675.2 1687.8 7276.8 7331.8 7417.2 7427.6 7461.7 7820.1 7899.2 7911.2 7917.4 7957.7 2267.6 2289.5 2293.9 2308.2 2308.5 2260.6 2272.7 2347.8 2348.2 2348.4 2111.4 2155.2 2222.3 2230.2 2261.8 2319.0 2343.7 2348.1 2358.8 2362.4 2277.4 2303.0 2330.9 2334.1 2335.1 7668.9 7706.5 7730.5 7745.5 7758.9 4649.6 4707.3 4727.5 4729.0 4758.6 2895.5 2976.9 3020.2 3031.7 3037.4 884.0 916.8 938.0 956.8 966.2 10194.2 10361.6 10365.1 10365.8 10379.5 4101.9 4122.4 4152.9 4162.4 4225.5 8612.7 8624.1 8650.1 8659.7 8670.0 4461.6 4462.5 4464.2 4468.4 4472.0 4090.1 4100.5 4108.9 4158.8 4160.5 3486.0 3488.1 3503.8 3522.8 3549.5 1038.8 1039.3 1041.9 1043.6 1059.2 971.3 972.5 1106.8 1169.7 1290.5 7015.0 7185.3 7205.8 7209.8 7210.8 1115.6 1122.6 1128.1 1140.7 1142.6 5429.7 5457.3 5502.4 5502.7 5543.5 8887.8 9115.2 9201.3 9261.4 9400.2 9196.3 9198.0 9211.8 9244.9 9312.3 7112.8 7153.8 7209.2 7243.6 7259.1 6960.5 7003.3 7011.6 7016.2 7023.9 7959.7 8110.3 8203.7 8236.1 8315.8 8321.8 8408.6 8444.9 8461.2 8504.8 6478.6 6479.7 6482.1 6486.1 6504.0 7342.0 7349.5 7371.0 7392.8 7440.3 6783.1 6785.8 7068.2 7140.6 7192.2 6546.4 6703.0 6744.9 6776.9 6839.5 6840.7 6886.9 6929.3 6946.2 6978.5 6259.4 6281.3 6299.4 6307.6 6352.0 6034.5 6097.3 6103.4 6357.8 6454.5 17:03:03 INFO - 2015-11-16 17:03:03,045 DEBUG : BROWSER_OUTPUT: 17:03:03 INFO - 2015-11-16 17:03:03,045 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5632.00 Median:6519.59 stddev:1769.18 (27.1%) stddev-sans-first:1728.56 17:03:03 INFO - 2015-11-16 17:03:03,046 DEBUG : BROWSER_OUTPUT: Values: 315.7 320.5 321.5 325.4 325.8 6343.4 6385.7 6445.6 6479.0 6549.9 6366.9 6381.8 6406.0 6410.9 6422.6 4630.6 4753.3 4770.2 4773.6 4791.0 4749.1 4763.6 4767.1 4770.9 4797.5 4689.3 4695.4 4697.9 4708.5 4716.6 4717.0 4723.4 4725.1 4725.2 4738.5 3965.2 4072.0 4073.5 4075.2 4090.6 6002.5 6013.5 6026.6 6040.2 6042.9 5479.6 5482.1 5510.5 5519.9 5522.1 6604.4 6698.7 6713.1 6717.9 6741.5 4499.1 4505.6 4507.4 4508.0 4508.1 6898.2 6966.4 6969.6 6979.5 6982.8 4559.9 4565.0 4572.5 4576.3 4582.7 4495.5 4553.0 4631.7 4631.8 4639.7 5406.3 5411.8 5414.6 5417.1 5434.4 6782.0 6787.1 6790.9 6791.2 6795.2 1642.9 1649.2 1650.5 1654.6 1654.7 1044.9 1051.9 1061.6 1063.2 1074.0 6517.4 6521.7 6524.6 6562.2 6660.8 7024.8 7073.9 7083.0 7101.0 7101.2 6611.2 6627.2 6635.3 6639.2 6644.9 3759.1 3814.7 3838.4 3843.4 3871.6 7326.2 7372.9 7376.0 7383.6 7389.6 7243.5 7254.1 7267.3 7299.6 7309.7 7173.6 7320.5 7356.9 7398.2 7434.5 7082.9 7096.1 7100.9 7108.3 7109.3 6859.7 6960.7 7011.5 7030.7 7034.9 7339.4 7356.9 7377.4 7397.9 7410.0 4514.8 4535.2 4546.2 4552.6 4583.1 6774.1 6961.0 6962.2 6965.2 6972.9 6813.9 6817.8 6819.5 6824.7 6829.2 6827.9 6829.8 6829.9 6836.0 6838.2 6454.8 6632.3 6648.6 6654.8 6676.9 6764.8 6794.2 6839.6 6872.5 6882.8 6698.6 6723.3 6731.6 6742.8 6763.8 17:03:03 INFO - 2015-11-16 17:03:03,046 DEBUG : BROWSER_OUTPUT: 17:03:03 INFO - 2015-11-16 17:03:03,046 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13674.85 Median:49603.63 stddev:16868.31 (34.0%) stddev-sans-first:16887.72 17:03:03 INFO - 2015-11-16 17:03:03,047 DEBUG : BROWSER_OUTPUT: Values: 751.9 774.9 785.6 848.0 858.7 14275.6 14287.5 14412.1 14469.8 14479.8 13441.3 13510.2 13521.6 13534.7 13540.5 668.5 678.4 808.6 815.1 826.1 819.4 820.3 821.6 830.9 831.6 858.9 872.0 873.3 874.2 874.5 856.0 860.9 861.5 862.8 863.7 638.7 644.3 645.1 645.7 646.0 12135.2 12201.0 12261.2 12280.6 12322.5 12407.4 13246.0 13274.8 13362.3 13442.2 10272.4 10373.3 10442.2 10448.7 10474.7 3338.1 3369.6 3405.5 3487.2 3498.2 45375.8 45677.9 45792.8 45927.0 45942.3 5617.2 5717.3 5729.3 5833.2 5936.2 9098.3 9164.5 9198.9 9221.3 9240.7 6983.3 7061.8 7097.8 7102.3 7283.6 4316.8 4324.8 4348.9 4366.6 4394.7 2807.0 2819.7 2821.4 2823.9 2826.2 452.1 454.1 461.5 462.1 471.0 681.4 689.7 707.6 708.8 752.2 8890.5 9383.0 9887.2 10019.9 10062.1 691.4 707.3 718.7 725.0 747.8 4000.2 4281.0 4313.8 4416.2 4475.9 62314.1 62824.0 63245.0 63351.7 63555.7 53208.2 53895.2 54260.5 54436.5 54495.5 48676.8 48841.8 48894.5 49238.8 49968.5 8611.8 8922.0 8960.8 8993.1 9016.2 34803.5 34973.8 35564.3 35593.8 36025.5 47273.3 47978.8 48038.6 48202.0 48491.5 7527.2 7577.4 8089.0 8297.7 8326.5 10254.9 10568.6 10642.7 10695.6 10719.7 11056.8 11190.1 11226.2 11295.3 11606.4 10808.9 10836.7 11082.6 11387.9 11510.8 10554.5 10955.6 11859.2 12217.7 12217.8 9244.9 9287.4 9307.9 9378.3 9900.4 8593.8 8943.0 9065.6 9516.5 9729.2 17:03:03 INFO - 2015-11-16 17:03:03,047 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:03:03 INFO - 2015-11-16 17:03:03,047 DEBUG : BROWSER_OUTPUT: 17:03:03 INFO - 2015-11-16 17:03:03,702 INFO : Browser exited with error code: 0 17:03:03 INFO - 2015-11-16 17:03:03,718 INFO : Completed test dromaeo_css (00:18:30) 17:03:03 INFO - 2015-11-16 17:03:03,718 INFO : Starting test kraken 17:03:03 INFO - 2015-11-16 17:03:03,718 DEBUG : operating with platform_type : linux_ 17:03:03 INFO - 2015-11-16 17:03:03,718 INFO : Initialising browser for kraken test... 17:03:03 INFO - 2015-11-16 17:03:03,724 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiRlWt_/profile http://localhost:50272/getInfo.html 17:03:07 INFO - 2015-11-16 17:03:07,666 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:03:07 INFO - 2015-11-16 17:03:07,667 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:03:07 INFO - 2015-11-16 17:03:07,667 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:03:07 INFO - 2015-11-16 17:03:07,667 DEBUG : BROWSER_OUTPUT: __metrics 17:03:08 INFO - 2015-11-16 17:03:08,693 INFO : Browser initialized. 17:03:08 INFO - 2015-11-16 17:03:08,694 INFO : Running cycle 1/1 for kraken test... 17:03:08 INFO - 2015-11-16 17:03:08,694 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiRlWt_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:03:20 INFO - 2015-11-16 17:03:20,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 141238272 17:03:20 INFO - 2015-11-16 17:03:20,494 DEBUG : BROWSER_OUTPUT: 17:03:22 INFO - 2015-11-16 17:03:22,968 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50272/tests/kraken/driver.html?testName=audio-beat-detection) 17:03:23 INFO - 2015-11-16 17:03:23,570 DEBUG : BROWSER_OUTPUT: RSS: Main: 141475840 17:03:23 INFO - 2015-11-16 17:03:23,571 DEBUG : BROWSER_OUTPUT: 17:03:26 INFO - 2015-11-16 17:03:26,228 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50272/tests/kraken/driver.html?testName=audio-dft) 17:03:26 INFO - 2015-11-16 17:03:26,821 DEBUG : BROWSER_OUTPUT: RSS: Main: 141111296 17:03:26 INFO - 2015-11-16 17:03:26,822 DEBUG : BROWSER_OUTPUT: 17:03:29 INFO - 2015-11-16 17:03:29,700 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50272/tests/kraken/driver.html?testName=audio-fft) 17:03:30 INFO - 2015-11-16 17:03:30,282 DEBUG : BROWSER_OUTPUT: RSS: Main: 136855552 17:03:30 INFO - 2015-11-16 17:03:30,282 DEBUG : BROWSER_OUTPUT: 17:03:32 INFO - 2015-11-16 17:03:32,577 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50272/tests/kraken/driver.html?testName=audio-oscillator) 17:03:33 INFO - 2015-11-16 17:03:33,171 DEBUG : BROWSER_OUTPUT: RSS: Main: 136359936 17:03:33 INFO - 2015-11-16 17:03:33,171 DEBUG : BROWSER_OUTPUT: 17:03:35 INFO - 2015-11-16 17:03:35,378 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:03:35 INFO - 2015-11-16 17:03:35,951 DEBUG : BROWSER_OUTPUT: RSS: Main: 136724480 17:03:35 INFO - 2015-11-16 17:03:35,951 DEBUG : BROWSER_OUTPUT: 17:03:38 INFO - 2015-11-16 17:03:38,955 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50272/tests/kraken/driver.html?testName=imaging-darkroom) 17:03:39 INFO - 2015-11-16 17:03:39,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 137957376 17:03:39 INFO - 2015-11-16 17:03:39,536 DEBUG : BROWSER_OUTPUT: 17:03:42 INFO - 2015-11-16 17:03:42,950 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50272/tests/kraken/driver.html?testName=imaging-desaturate) 17:03:43 INFO - 2015-11-16 17:03:43,552 DEBUG : BROWSER_OUTPUT: RSS: Main: 139567104 17:03:43 INFO - 2015-11-16 17:03:43,552 DEBUG : BROWSER_OUTPUT: 17:03:46 INFO - 2015-11-16 17:03:46,418 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50272/tests/kraken/driver.html?testName=json-parse-financial) 17:03:47 INFO - 2015-11-16 17:03:47,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 139468800 17:03:47 INFO - 2015-11-16 17:03:47,005 DEBUG : BROWSER_OUTPUT: 17:03:48 INFO - 2015-11-16 17:03:48,574 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:03:49 INFO - 2015-11-16 17:03:49,155 DEBUG : BROWSER_OUTPUT: RSS: Main: 137195520 17:03:49 INFO - 2015-11-16 17:03:49,156 DEBUG : BROWSER_OUTPUT: 17:03:50 INFO - 2015-11-16 17:03:50,999 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50272/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:03:51 INFO - 2015-11-16 17:03:51,613 DEBUG : BROWSER_OUTPUT: RSS: Main: 138735616 17:03:51 INFO - 2015-11-16 17:03:51,613 DEBUG : BROWSER_OUTPUT: 17:03:53 INFO - 2015-11-16 17:03:53,677 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:03:54 INFO - 2015-11-16 17:03:54,263 DEBUG : BROWSER_OUTPUT: RSS: Main: 137666560 17:03:54 INFO - 2015-11-16 17:03:54,263 DEBUG : BROWSER_OUTPUT: 17:03:56 INFO - 2015-11-16 17:03:56,719 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:03:57 INFO - 2015-11-16 17:03:57,321 DEBUG : BROWSER_OUTPUT: RSS: Main: 138391552 17:03:57 INFO - 2015-11-16 17:03:57,321 DEBUG : BROWSER_OUTPUT: 17:03:59 INFO - 2015-11-16 17:03:59,889 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:04:00 INFO - 2015-11-16 17:04:00,475 DEBUG : BROWSER_OUTPUT: RSS: Main: 138498048 17:04:00 INFO - 2015-11-16 17:04:00,475 DEBUG : BROWSER_OUTPUT: 17:04:02 INFO - 2015-11-16 17:04:02,116 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50272/tests/kraken/driver.html?testName=ai-astar) 17:04:02 INFO - 2015-11-16 17:04:02,366 DEBUG : BROWSER_OUTPUT: RSS: Main: 139780096 17:04:02 INFO - 2015-11-16 17:04:02,366 DEBUG : BROWSER_OUTPUT: 17:04:02 INFO - 2015-11-16 17:04:02,366 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:04:02 INFO - 2015-11-16 17:04:02,368 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:04:02 INFO - 2015-11-16 17:04:02,368 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:04:02 INFO - 2015-11-16 17:04:02,368 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:04:02 INFO - 2015-11-16 17:04:02,368 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;106;110;110;113;122;109;110;109;110 17:04:02 INFO - 2015-11-16 17:04:02,368 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;124;157;177;130;152;160;129;165;129 17:04:02 INFO - 2015-11-16 17:04:02,368 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;162;163;163;163;163;162;166;171;163 17:04:02 INFO - 2015-11-16 17:04:02,369 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;73;73;72;73;73;73;130;73;81 17:04:02 INFO - 2015-11-16 17:04:02,369 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;90;139;91;91;90;139;90;91;137 17:04:02 INFO - 2015-11-16 17:04:02,369 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;111;109;111;111;110;110 17:04:02 INFO - 2015-11-16 17:04:02,369 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;147;147;147;146;148;148;147;147 17:04:02 INFO - 2015-11-16 17:04:02,369 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;98;96;96;96;96;96;96 17:04:02 INFO - 2015-11-16 17:04:02,369 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;64;60;62;61;60;65;61;61;63;59 17:04:02 INFO - 2015-11-16 17:04:02,369 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;71;70;74;70;69;70;70 17:04:02 INFO - 2015-11-16 17:04:02,370 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;86;87;85;86;85;85;86;86;86 17:04:02 INFO - 2015-11-16 17:04:02,370 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;115;119;118;126;117;124;117;123;116;138 17:04:02 INFO - 2015-11-16 17:04:02,370 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;140;162;146;150;137;146;158;145;142 17:04:02 INFO - 2015-11-16 17:04:02,370 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;65;66;66;68;68;65;65;66;65 17:04:02 INFO - 2015-11-16 17:04:02,370 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:04:02 INFO - 2015-11-16 17:04:02,370 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:04:02 INFO - 2015-11-16 17:04:02,370 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,715 17:04:02 INFO - 2015-11-16 17:04:02,370 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:04:02 INFO - 2015-11-16 17:04:02,371 DEBUG : BROWSER_OUTPUT: __startTimestamp1447722242365__endTimestamp 17:04:02 INFO - 2015-11-16 17:04:02,371 DEBUG : BROWSER_OUTPUT: 17:04:02 INFO - 2015-11-16 17:04:02,374 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:04:02 INFO - 2015-11-16 17:04:02,374 DEBUG : BROWSER_OUTPUT: Number of tests: 14 17:04:02 INFO - 2015-11-16 17:04:02,374 DEBUG : BROWSER_OUTPUT: 17:04:02 INFO - 2015-11-16 17:04:02,375 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.10 Median:110.00 stddev:4.25 (3.9%) stddev-sans-first:4.50 17:04:02 INFO - 2015-11-16 17:04:02,375 DEBUG : BROWSER_OUTPUT: Values: 112.0 106.0 110.0 110.0 113.0 122.0 109.0 110.0 109.0 110.0 17:04:02 INFO - 2015-11-16 17:04:02,375 DEBUG : BROWSER_OUTPUT: 17:04:02 INFO - 2015-11-16 17:04:02,375 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.30 Median:154.50 stddev:18.23 (11.8%) stddev-sans-first:19.31 17:04:02 INFO - 2015-11-16 17:04:02,375 DEBUG : BROWSER_OUTPUT: Values: 150.0 124.0 157.0 177.0 130.0 152.0 160.0 129.0 165.0 129.0 17:04:02 INFO - 2015-11-16 17:04:02,375 DEBUG : BROWSER_OUTPUT: 17:04:02 INFO - 2015-11-16 17:04:02,376 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.90 Median:163.00 stddev:2.73 (1.7%) stddev-sans-first:2.87 17:04:02 INFO - 2015-11-16 17:04:02,376 DEBUG : BROWSER_OUTPUT: Values: 163.0 162.0 163.0 163.0 163.0 163.0 162.0 166.0 171.0 163.0 17:04:02 INFO - 2015-11-16 17:04:02,376 DEBUG : BROWSER_OUTPUT: 17:04:02 INFO - 2015-11-16 17:04:02,376 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.20 Median:73.00 stddev:18.05 (24.7%) stddev-sans-first:18.90 17:04:02 INFO - 2015-11-16 17:04:02,376 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 73.0 72.0 73.0 73.0 73.0 130.0 73.0 81.0 17:04:02 INFO - 2015-11-16 17:04:02,377 DEBUG : BROWSER_OUTPUT: 17:04:02 INFO - 2015-11-16 17:04:02,377 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.70 Median:90.00 stddev:23.22 (25.8%) stddev-sans-first:23.93 17:04:02 INFO - 2015-11-16 17:04:02,377 DEBUG : BROWSER_OUTPUT: Values: 89.0 90.0 139.0 91.0 91.0 90.0 139.0 90.0 91.0 137.0 17:04:02 INFO - 2015-11-16 17:04:02,377 DEBUG : BROWSER_OUTPUT: 17:04:02 INFO - 2015-11-16 17:04:02,377 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 17:04:02 INFO - 2015-11-16 17:04:02,377 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 111.0 109.0 111.0 111.0 110.0 110.0 17:04:02 INFO - 2015-11-16 17:04:02,377 DEBUG : BROWSER_OUTPUT: 17:04:02 INFO - 2015-11-16 17:04:02,378 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 17:04:02 INFO - 2015-11-16 17:04:02,378 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 147.0 147.0 147.0 146.0 148.0 148.0 147.0 147.0 17:04:02 INFO - 2015-11-16 17:04:02,378 DEBUG : BROWSER_OUTPUT: 17:04:02 INFO - 2015-11-16 17:04:02,378 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 17:04:02 INFO - 2015-11-16 17:04:02,378 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 98.0 96.0 96.0 96.0 96.0 96.0 96.0 17:04:02 INFO - 2015-11-16 17:04:02,378 DEBUG : BROWSER_OUTPUT: 17:04:02 INFO - 2015-11-16 17:04:02,378 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.60 Median:61.50 stddev:1.90 (3.1%) stddev-sans-first:1.80 17:04:02 INFO - 2015-11-16 17:04:02,378 DEBUG : BROWSER_OUTPUT: Values: 64.0 60.0 62.0 61.0 60.0 65.0 61.0 61.0 63.0 59.0 17:04:02 INFO - 2015-11-16 17:04:02,378 DEBUG : BROWSER_OUTPUT: 17:04:02 INFO - 2015-11-16 17:04:02,379 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.00 stddev:1.52 (2.2%) stddev-sans-first:1.56 17:04:02 INFO - 2015-11-16 17:04:02,379 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 71.0 70.0 74.0 70.0 69.0 70.0 70.0 17:04:02 INFO - 2015-11-16 17:04:02,379 DEBUG : BROWSER_OUTPUT: 17:04:02 INFO - 2015-11-16 17:04:02,379 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:86.00 stddev:0.84 (1.0%) stddev-sans-first:0.67 17:04:02 INFO - 2015-11-16 17:04:02,379 DEBUG : BROWSER_OUTPUT: Values: 84.0 86.0 87.0 85.0 86.0 85.0 85.0 86.0 86.0 86.0 17:04:02 INFO - 2015-11-16 17:04:02,379 DEBUG : BROWSER_OUTPUT: 17:04:02 INFO - 2015-11-16 17:04:02,379 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:121.00 stddev:6.93 (5.7%) stddev-sans-first:6.96 17:04:02 INFO - 2015-11-16 17:04:02,379 DEBUG : BROWSER_OUTPUT: Values: 115.0 119.0 118.0 126.0 117.0 124.0 117.0 123.0 116.0 138.0 17:04:02 INFO - 2015-11-16 17:04:02,379 DEBUG : BROWSER_OUTPUT: 17:04:02 INFO - 2015-11-16 17:04:02,379 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.10 Median:146.00 stddev:7.74 (5.3%) stddev-sans-first:8.17 17:04:02 INFO - 2015-11-16 17:04:02,380 DEBUG : BROWSER_OUTPUT: Values: 145.0 140.0 162.0 146.0 150.0 137.0 146.0 158.0 145.0 142.0 17:04:02 INFO - 2015-11-16 17:04:02,380 DEBUG : BROWSER_OUTPUT: 17:04:02 INFO - 2015-11-16 17:04:02,380 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.15 (1.7%) stddev-sans-first:1.22 17:04:02 INFO - 2015-11-16 17:04:02,380 DEBUG : BROWSER_OUTPUT: Values: 66.0 65.0 66.0 66.0 68.0 68.0 65.0 65.0 66.0 65.0 17:04:02 INFO - 2015-11-16 17:04:02,380 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:04:02 INFO - 2015-11-16 17:04:02,380 DEBUG : BROWSER_OUTPUT: 17:04:03 INFO - 2015-11-16 17:04:03,230 INFO : Browser exited with error code: 0 17:04:03 INFO - 2015-11-16 17:04:03,281 INFO : Completed test kraken (00:00:59) 17:04:03 INFO - 2015-11-16 17:04:03,281 INFO : Starting test v8_7 17:04:03 INFO - 2015-11-16 17:04:03,281 DEBUG : operating with platform_type : linux_ 17:04:03 INFO - 2015-11-16 17:04:03,281 INFO : Initialising browser for v8_7 test... 17:04:03 INFO - 2015-11-16 17:04:03,287 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQo93zY/profile http://localhost:50272/getInfo.html 17:04:07 INFO - 2015-11-16 17:04:07,349 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:04:07 INFO - 2015-11-16 17:04:07,349 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:04:07 INFO - 2015-11-16 17:04:07,349 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:04:07 INFO - 2015-11-16 17:04:07,349 DEBUG : BROWSER_OUTPUT: __metrics 17:04:08 INFO - 2015-11-16 17:04:08,313 INFO : Browser initialized. 17:04:08 INFO - 2015-11-16 17:04:08,314 INFO : Running cycle 1/1 for v8_7 test... 17:04:08 INFO - 2015-11-16 17:04:08,314 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQo93zY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:04:20 INFO - 2015-11-16 17:04:20,073 DEBUG : BROWSER_OUTPUT: RSS: Main: 141389824 17:04:20 INFO - 2015-11-16 17:04:20,073 DEBUG : BROWSER_OUTPUT: 17:04:41 INFO - 2015-11-16 17:04:41,491 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50272/tests/v8_7/run.html (next: http://localhost:50272/tests/v8_7/run.html) 17:04:41 INFO - 2015-11-16 17:04:41,749 DEBUG : BROWSER_OUTPUT: RSS: Main: 138752000 17:04:41 INFO - 2015-11-16 17:04:41,749 DEBUG : BROWSER_OUTPUT: 17:04:41 INFO - 2015-11-16 17:04:41,749 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:04:41 INFO - 2015-11-16 17:04:41,749 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:04:41 INFO - 2015-11-16 17:04:41,749 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:04:41 INFO - 2015-11-16 17:04:41,750 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:04:41 INFO - 2015-11-16 17:04:41,750 DEBUG : BROWSER_OUTPUT: |0;Richards;162.31131309852296 17:04:41 INFO - 2015-11-16 17:04:41,750 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.62826002335538 17:04:41 INFO - 2015-11-16 17:04:41,750 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.4950213371266 17:04:41 INFO - 2015-11-16 17:04:41,750 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5045.226130653266 17:04:41 INFO - 2015-11-16 17:04:41,750 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1058.2010582010582 17:04:41 INFO - 2015-11-16 17:04:41,750 DEBUG : BROWSER_OUTPUT: |5;Earley;722.543352601156 17:04:41 INFO - 2015-11-16 17:04:41,750 DEBUG : BROWSER_OUTPUT: |6;Boyer;12132.530120481928 17:04:41 INFO - 2015-11-16 17:04:41,751 DEBUG : BROWSER_OUTPUT: |7;RegExp;25200 17:04:41 INFO - 2015-11-16 17:04:41,751 DEBUG : BROWSER_OUTPUT: |8;Splay;653.1678641410842 17:04:41 INFO - 2015-11-16 17:04:41,751 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 17:04:41 INFO - 2015-11-16 17:04:41,751 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:04:41 INFO - 2015-11-16 17:04:41,751 DEBUG : BROWSER_OUTPUT: __startTimestamp1447722281743__endTimestamp 17:04:41 INFO - 2015-11-16 17:04:41,751 DEBUG : BROWSER_OUTPUT: 17:04:41 INFO - 2015-11-16 17:04:41,751 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:04:41 INFO - 2015-11-16 17:04:41,751 DEBUG : BROWSER_OUTPUT: Number of tests: 10 17:04:41 INFO - 2015-11-16 17:04:41,751 DEBUG : BROWSER_OUTPUT: 17:04:41 INFO - 2015-11-16 17:04:41,752 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.31 Median:162.31 stddev:0.00 (0.0%) 17:04:41 INFO - 2015-11-16 17:04:41,752 DEBUG : BROWSER_OUTPUT: Values: 162.3 17:04:41 INFO - 2015-11-16 17:04:41,752 DEBUG : BROWSER_OUTPUT: 17:04:41 INFO - 2015-11-16 17:04:41,752 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.63 Median:194.63 stddev:0.00 (0.0%) 17:04:41 INFO - 2015-11-16 17:04:41,752 DEBUG : BROWSER_OUTPUT: Values: 194.6 17:04:41 INFO - 2015-11-16 17:04:41,752 DEBUG : BROWSER_OUTPUT: 17:04:41 INFO - 2015-11-16 17:04:41,752 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.50 Median:284.50 stddev:0.00 (0.0%) 17:04:41 INFO - 2015-11-16 17:04:41,752 DEBUG : BROWSER_OUTPUT: Values: 284.5 17:04:41 INFO - 2015-11-16 17:04:41,752 DEBUG : BROWSER_OUTPUT: 17:04:41 INFO - 2015-11-16 17:04:41,752 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5045.23 Median:5045.23 stddev:0.00 (0.0%) 17:04:41 INFO - 2015-11-16 17:04:41,753 DEBUG : BROWSER_OUTPUT: Values: 5045.2 17:04:41 INFO - 2015-11-16 17:04:41,753 DEBUG : BROWSER_OUTPUT: 17:04:41 INFO - 2015-11-16 17:04:41,753 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1058.20 Median:1058.20 stddev:0.00 (0.0%) 17:04:41 INFO - 2015-11-16 17:04:41,753 DEBUG : BROWSER_OUTPUT: Values: 1058.2 17:04:41 INFO - 2015-11-16 17:04:41,753 DEBUG : BROWSER_OUTPUT: 17:04:41 INFO - 2015-11-16 17:04:41,753 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:722.54 Median:722.54 stddev:0.00 (0.0%) 17:04:41 INFO - 2015-11-16 17:04:41,753 DEBUG : BROWSER_OUTPUT: Values: 722.5 17:04:41 INFO - 2015-11-16 17:04:41,753 DEBUG : BROWSER_OUTPUT: 17:04:41 INFO - 2015-11-16 17:04:41,753 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12132.53 Median:12132.53 stddev:0.00 (0.0%) 17:04:41 INFO - 2015-11-16 17:04:41,753 DEBUG : BROWSER_OUTPUT: Values: 12132.5 17:04:41 INFO - 2015-11-16 17:04:41,753 DEBUG : BROWSER_OUTPUT: 17:04:41 INFO - 2015-11-16 17:04:41,753 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25200.00 Median:25200.00 stddev:0.00 (0.0%) 17:04:41 INFO - 2015-11-16 17:04:41,753 DEBUG : BROWSER_OUTPUT: Values: 25200.0 17:04:41 INFO - 2015-11-16 17:04:41,754 DEBUG : BROWSER_OUTPUT: 17:04:41 INFO - 2015-11-16 17:04:41,754 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:653.17 Median:653.17 stddev:0.00 (0.0%) 17:04:41 INFO - 2015-11-16 17:04:41,754 DEBUG : BROWSER_OUTPUT: Values: 653.2 17:04:41 INFO - 2015-11-16 17:04:41,754 DEBUG : BROWSER_OUTPUT: 17:04:41 INFO - 2015-11-16 17:04:41,754 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 17:04:41 INFO - 2015-11-16 17:04:41,754 DEBUG : BROWSER_OUTPUT: Values: 4845.4 17:04:41 INFO - 2015-11-16 17:04:41,754 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:04:41 INFO - 2015-11-16 17:04:41,754 DEBUG : BROWSER_OUTPUT: 17:04:42 INFO - 2015-11-16 17:04:42,645 INFO : Browser exited with error code: 0 17:04:42 INFO - 2015-11-16 17:04:42,662 INFO : Completed test v8_7 (00:00:39) 17:04:42 INFO - 2015-11-16 17:04:42,750 INFO : Completed test suite (00:20:09) 17:04:42 INFO - 2015-11-16 17:04:42,750 DEBUG : Working with test: dromaeo_css 17:04:42 INFO - 2015-11-16 17:04:42,750 DEBUG : Generating results file: dromaeo_css 17:04:42 INFO - 2015-11-16 17:04:42,751 DEBUG : Working with test: kraken 17:04:42 INFO - 2015-11-16 17:04:42,751 DEBUG : Generating results file: kraken 17:04:42 INFO - 2015-11-16 17:04:42,752 INFO : javascript benchmark 17:04:42 INFO - 2015-11-16 17:04:42,752 DEBUG : Working with test: v8_7 17:04:42 INFO - 2015-11-16 17:04:42,752 DEBUG : Generating results file: v8_7 17:04:42 INFO - 2015-11-16 17:04:42,752 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:04:42 INFO - 2015-11-16 17:04:42,806 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 17:04:42 INFO - 2015-11-16 17:04:42,806 DEBUG : process_Request line: dromaeo_css 6768.58 graph.html#tests=[[72,64,43]] 17:04:42 INFO - 2015-11-16 17:04:42,806 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:04:42 INFO - 2015-11-16 17:04:42,837 DEBUG : process_Request line: kraken 1511.40 graph.html#tests=[[232,64,43]] 17:04:42 INFO - 2015-11-16 17:04:42,837 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:04:42 INFO - 2015-11-16 17:04:42,865 DEBUG : process_Request line: v8_7 21226.53 graph.html#tests=[[230,64,43]] 17:04:42 INFO - 2015-11-16 17:04:42,867 INFO : javascript benchmark 17:04:42 INFO - 2015-11-16 17:04:42,871 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [348.81861432055314, 349.5368636556563, 350.08103727714746, 353.3498363012058, 353.47508949210436, 12350.752984940296, 12843.614691559245, 16554.17229138543, 17743.37898173564, 18823.71764423535, 11846.644600661972, 11898.64304070877, 11900.642980710592, 12053.39733013348, 12293.569725059602, 4417.0944956283965, 4522.1181869535285, 4552.112338094073, 4563.315502674593, 4566.748828814414, 4729.0, 4865.48912364202, 4875.341828853113, 4877.829275975341, 4879.097366987119, 3517.8416971236356, 3568.3220188164164, 4801.135795556798, 4802.03959208158, 4816.879578010543, 4935.23503856901, 5020.297158397827, 5056.6713163644245, 5059.089363914494, 5078.873028174288, 4276.743395396286, 4332.501762297345, 4348.043430445297, 4349.151915376503, 4361.040571074359, 13309.933450332686, 13502.122362046533, 13543.525976590772, 13675.384607692678, 13688.0, 1919.251491918153, 1993.6311782320317, 2055.126571207231, 2073.1085633177727, 2134.018351558285, 9860.506974651238, 10078.244131690153, 10085.596576136946, 10301.690949271533, 10348.94825525875, 1681.7477378393216, 1687.822778608253, 1703.8722095842738, 1740.8955462672154, 1781.1628534588722, 58691.906225636376, 61405.07892381618, 62482.37517624811, 62879.0, 62901.68549157225, 6897.103376561015, 6981.05755722981, 7045.577265364094, 7059.82350441243, 7131.928680713127, 8407.74776756686, 8422.441848258091, 8467.407281490237, 8485.32117430604, 8501.107383724744, 5549.19536667181, 5550.528205102531, 5551.916721249185, 5580.2745643066955, 5596.664200147923, 5554.527865131509, 5559.916601250984, 5564.610477266633, 5638.126090455986, 5725.112607545837, 3263.233140212048, 3274.6070471543567, 3304.5208444775853, 3307.255867429809, 3313.801171929692, 1175.1127898436625, 1179.3395698408747, 1182.491528642692, 1186.9525218991316, 1223.5411720604773, 463.08771719712115, 464.7792298658178, 474.563401670464, 475.2040332443144, 493.85431297767246, 10601.73495662599, 10989.670309890716, 11668.416579171007, 11826.704332391759, 12513.124081314403, 503.40849501835197, 511.4246472718192, 519.0086933956126, 525.6425630571172, 527.4330095147654, 6387.648679322589, 6538.476921846241, 6614.206295244505, 6635.734570617218, 6707.5975441473665, 481867.0, 493024.0, 501032.0, 503342.0, 506982.0, 77499.61250193712, 79434.20565794384, 80150.0, 80974.0, 81505.0, 569.5728203847115, 571.725571725574, 576.9163471296639, 578.7453520451072, 580.8344621782857, 11036.834447483454, 11271.605493808005, 11279.436028198721, 11312.490937907649, 11479.770404591694, 35596.466053008706, 35975.64024359723, 36056.0, 37497.62502374942, 37565.624343756215, 48431.27353089777, 48578.757106214245, 50077.49922500728, 50534.0, 50610.0, 6781.38967492928, 6797.422219111233, 6915.343042410963, 6915.89626155598, 6928.965355173192, 12042.157049006835, 12270.81593776112, 12291.508339666314, 12435.253884766942, 12632.178908370926, 9099.909000910171, 10925.726856828325, 11143.498542565441, 11155.83266251023, 11161.33032018049, 9694.418334899929, 9720.319577629498, 9751.171150452292, 9825.705228843146, 10239.18086553059, 9691.70924872255, 9759.9024009759, 9933.056359645821, 10188.490575471345, 10198.0, 14446.855531444551, 14547.399786023741, 14789.852101478848, 14927.850721492647, 15066.171360575274, 15740.134292614017, 15902.68194636124, 16006.519804405887, 16195.919020404823, 16357.936734112245], "dojo.html": [3246.513023046543, 3266.7876588021777, 3300.7029367356963, 3307.421201289774, 3313.353895990283, 5375.946240537593, 5527.557795376375, 5542.0855558832745, 5551.195076713879, 5556.305461817273, 5495.477929596682, 5568.86077848054, 5612.831615051545, 5622.184783206432, 5650.0959846424585, 5028.7485625718655, 5090.77091530882, 5140.563052140573, 5183.041137389595, 5196.92204616931, 5031.974840125794, 5064.088464076464, 5064.164412871872, 5073.492650734934, 5095.515925987025, 4621.145088158668, 4850.6362022848425, 4943.233798761198, 5105.132127538309, 5107.157319042353, 4992.600591952635, 5004.599632029429, 5015.749212539395, 5023.271625614266, 5071.416787069497, 5000.549950504435, 5025.0954828130925, 5040.1179793535985, 5048.040872234264, 5066.138756411382, 5259.605529585297, 5306.575473962073, 5353.518183363477, 5379.784808607651, 5410.783568657249, 6050.2134722486235, 6113.449789518964, 6135.539834512385, 6140.0789881517685, 6149.29283132441, 5886.6468011919, 6168.475679567242, 6173.074038894157, 6178.135061091406, 6182.96908515459, 5492.258545096401, 5647.604667673265, 5727.885442291131, 5745.224394706703, 5780.219670344533, 5999.070144127667, 6008.3390827009, 6010.729517171738, 6010.939890601126, 6027.336992930862, 5782.739776710058, 5866.911996319973, 5882.55880808941, 5885.3820348862755, 5893.793717219876, 5919.852003699856, 5956.583039187215, 5972.343042265347, 5981.641101533834, 6012.819615411545, 6042.3655516170165, 6057.454829065406, 6066.393360663987, 6068.302145253352, 6078.908816367758, 5754.88490230193, 5864.560157988082, 5875.529957603467, 5990.970045149834, 6001.939980600138, 4616.584507394351, 4623.768811559408, 4633.536646335407, 4638.628909687217, 4639.095376401569, 4085.9182816343505, 4098.323776576891, 4116.75299482026, 4124.298869192245, 4155.397467367215, 5475.616706830484, 5569.66582005081, 5632.3804381518, 5742.196092547047, 5811.27359080115, 6038.879222415615, 6053.697315134225, 6076.0885867119405, 6080.969595151996, 6084.969575152096, 5707.828765137053, 5727.083666613322, 5741.971290143522, 5755.740991655385, 5763.0, 4995.600351971906, 5083.262926875583, 5102.36220472441, 5192.324997750268, 5209.6353255272525, 6232.688365581703, 6266.843328916722, 6282.874342513124, 6285.96857015712, 6287.056941458726, 5826.504747096545, 6070.2108725865355, 6073.271207454957, 6095.51235901118, 6102.725377358119, 6060.212172417558, 6106.877862442638, 6163.8150855474405, 6204.0, 6227.0, 5960.940390596039, 6006.039033754753, 6007.729652165575, 6011.188489553854, 6020.729067191899, 5775.451332123442, 5861.0, 6049.848753781191, 6080.452759251689, 6082.787102451393, 5755.5683323750045, 5758.481736643722, 5848.181254624271, 5860.765569377178, 5897.144913987362, 5835.183074369676, 5930.229070220844, 5930.377310382521, 5964.850878727893, 5965.940340596539, 5628.577856660685, 5699.971500142473, 5785.595008349375, 5820.214271073351, 5830.300363956352, 5914.4381283777975, 5968.343482217039, 5971.880562388641, 5974.581779275582, 5987.550933679904, 5782.942170578409, 5799.4780469757925, 5811.738471768866, 5813.82558523245, 5818.2436283282905], "mootools.html": [1420.6448387903024, 1619.2146808797731, 1671.4066506390232, 1675.1540472061606, 1687.7637130801681, 7276.781696549098, 7331.780046598597, 7417.184109747924, 7427.628618569077, 7461.664225109869, 7820.139784623701, 7899.170587088359, 7911.208879112086, 7917.366610671147, 7957.681692732298, 2267.5804976079435, 2289.5077558324956, 2293.919712810052, 2308.226744040748, 2308.480591866825, 2260.559190957764, 2272.7045484087043, 2347.835651504395, 2348.1546643208517, 2348.3542025942834, 2111.398251498323, 2155.245664017589, 2222.3333000099988, 2230.163688616769, 2261.796438320551, 2319.0491898321693, 2343.6836027136287, 2348.1077190667606, 2358.7759162879497, 2362.3857796972825, 2277.3737222263844, 2302.988485057564, 2330.8951097200666, 2334.0897050150456, 2335.065973610552, 7668.884966725448, 7706.537607743553, 7730.458867879251, 7745.496542724705, 7758.883616745753, 4649.628029757645, 4707.340972263886, 4727.5272472752795, 4728.95271047292, 4758.571728544448, 2895.5077636801793, 2976.866041028159, 3020.1845501714415, 3031.711987361219, 3037.3621539476735, 883.9602217900145, 916.757059379265, 938.029139840262, 956.8277710012195, 966.1980556138388, 10194.184465242763, 10361.63734269297, 10365.118964887994, 10365.844512332396, 10379.532921018572, 4101.8974525637095, 4122.40225167349, 4152.896177595524, 4162.438070860395, 4225.464721167336, 8612.65549378018, 8624.051354351017, 8650.09174036717, 8659.653613855502, 8669.956650216709, 4461.553844615512, 4462.531434199363, 4464.2187617166865, 4468.419105516262, 4471.977640111843, 4090.1206240658403, 4100.5489396166395, 4108.938365924513, 4158.812853421603, 4160.54234034256, 3485.9651403486146, 3488.075659950115, 3503.7547371683736, 3522.8238588070494, 3549.5208146900354, 1038.7610849504656, 1039.3036665434176, 1041.9270651054505, 1043.5564884923876, 1059.2426415113232, 971.3103696375512, 972.4700038479045, 1106.773111512138, 1169.7485040716288, 1290.4838064774165, 7015.0, 7185.317394847481, 7205.7838264852135, 7209.783706488814, 7210.819729506699, 1115.5593540551438, 1122.5565901469038, 1128.1257025805066, 1140.7262257058412, 1142.5544037825255, 5429.701366424884, 5457.345118585716, 5502.367227768777, 5502.697351645698, 5543.52880005196, 8887.822243555092, 9115.225205857443, 9201.309901757395, 9261.44431334122, 9400.24798016157, 9196.264298856075, 9197.95401023004, 9211.815763684823, 9244.8613270801, 9312.348135630577, 7112.822179445452, 7153.821154471076, 7209.170945341353, 7243.637818109073, 7259.092613423322, 6960.4779641526075, 7003.26465721092, 7011.6494175292055, 7016.19313778922, 7023.929760702327, 7959.681612735426, 8110.270075693216, 8203.671853126047, 8236.052853921876, 8315.792105197177, 8321.750347489586, 8408.621612027597, 8444.944381952257, 8461.153884611736, 8504.787380315542, 6478.611283323015, 6479.7247162755475, 6482.092507048923, 6486.091947127312, 6504.0, 7341.963290183515, 7349.522281051714, 7371.041764570571, 7392.815179620553, 7440.2931721486375, 6783.084283621648, 6785.830354241183, 7068.222495525591, 7140.642967851691, 7192.244814294424, 6546.443552298108, 6702.966485167543, 6744.8651026978205, 6776.86446271062, 6839.487038472035, 6840.657967101525, 6886.931130688629, 6929.272426395358, 6946.2011868635755, 6978.546394484342, 6259.405356491126, 6281.277653069956, 6299.433051025429, 6307.621542707452, 6352.0, 6034.487068599218, 6097.2683278006925, 6103.42017508336, 6357.809265722036, 6454.5159113065765], "ext.html": [558.9659130608372, 574.7212601888085, 613.2365205319377, 613.7943788830742, 675.4967549175861, 31156.22109447262, 32109.678903210992, 40369.39445908314, 40818.59181408185, 40929.590704093025, 42894.0, 43425.34861977073, 43548.12903741923, 43625.34561981573, 43652.345214821726, 8645.265152462049, 8734.912650873504, 8760.12398760122, 8813.64745410186, 8823.2941364691, 8525.317974562051, 8622.913770862273, 8641.481511109321, 8642.265407440374, 8650.26472749814, 8657.523836189008, 8724.52015139167, 8752.081031491698, 8776.0, 8779.473231606124, 8621.65513379464, 8679.479231246114, 8695.652173913037, 8711.695090671828, 8716.825663486758, 8537.317014638815, 8622.913770862273, 8672.739817805475, 8679.262262707678, 8680.696175633886, 39455.21089578192, 39685.0, 39686.60313396887, 39924.0, 39949.20101597952, 3293.4730443129224, 3313.9834300828584, 3352.379809735207, 3386.7121294689737, 3888.5333759948985, 29202.853985729937, 29501.852490737623, 29952.25119372033, 30545.541816872767, 30634.387312253853, 3509.78941263525, 3533.808023963425, 3534.929301413983, 3621.7102631789394, 3673.522442082512, 266277.0, 267126.0, 267132.0, 268700.0, 270562.47187640733, 56104.43895560992, 56203.71898140483, 56597.71701141468, 57350.0, 58254.0, 54124.0, 54174.45825541694, 54193.45806541963, 54377.0, 54509.72745136249, 15034.548963531111, 15143.621409464631, 15308.081515109128, 15314.923425382802, 15346.23268836576, 10826.40454774995, 10899.564017439214, 10989.395583242838, 10990.615328463466, 10992.230543861853, 18837.0, 18842.528936776416, 18863.90568047151, 18914.243430262635, 18959.62080758377, 7249.637518124073, 7341.229170937081, 7404.296591823768, 7461.403087752967, 7469.551826890404, 935.1209862729013, 983.6508039645822, 988.8170688422665, 997.4414327976357, 1036.5594622285648, 28649.71350286512, 28882.0, 29100.563491547644, 29303.85348073246, 29375.412491750045, 1084.3602274657833, 1119.339589642115, 1127.115214556569, 1191.065013964034, 1208.0878936403135, 14954.40182392692, 15104.0, 15411.22943852803, 15435.151066691215, 15457.432149062495, 312858.0, 314060.0, 314159.0, 314799.0, 316076.0, 52356.214656780176, 52469.212961805606, 52514.737426312626, 52565.47434525682, 52745.0, 1333.3666508408621, 1363.3319673359783, 1365.6312795545148, 1366.719822436398, 1370.0067451098073, 27894.0, 28554.42891142207, 28925.276868078465, 29065.564016540193, 29343.266418339714, 47693.52306476891, 48616.270755937985, 48834.26748598703, 48900.5109948896, 49072.263916040574, 272361.0, 273205.0, 275395.0, 276114.0, 276971.0, 31078.68921310758, 31492.370152596362, 31695.207619809687, 31906.840465797522, 32384.676153238164, 38257.0, 38408.61591384162, 38491.61508384992, 38994.80502597469, 39262.4110638335, 33322.66677333292, 34545.30909381748, 35902.820485898446, 35997.64002359943, 36166.27667446689, 33060.834695826365, 34519.0, 34588.65411345854, 35589.644103559665, 36228.63771362253, 32602.34795304128, 32874.342513149124, 33066.66933330636, 33373.499397508574, 35393.64606353903, 27863.24363132274, 29198.124056278346, 30755.84622076875, 31032.0, 31047.84476077605, 25109.372265693502, 25233.74766252314, 25417.237482875542, 25747.485050299263, 25875.61186582165], "prototype.html": [315.65908818476044, 320.4728222074686, 321.4583426925632, 325.40288570473183, 325.8077734136859, 6343.429091381775, 6385.680715964207, 6445.613263204205, 6479.0, 6549.869002619945, 6366.936330636692, 6381.840453988652, 6406.0, 6410.935890641093, 6422.614643121416, 4630.606398456135, 4753.33453316536, 4770.189067858472, 4773.57037866592, 4791.0, 4749.073930583538, 4763.571278584926, 4767.11808315461, 4770.856874293777, 4797.544233297831, 4689.320048592969, 4695.413073365829, 4697.88255293617, 4708.505606911276, 4716.599089077433, 4716.97641511792, 4723.36234608327, 4725.10223057618, 4725.173094708447, 4738.549837765407, 3965.167314863882, 4072.0023594219606, 4073.5111786585503, 4075.1645912587846, 4090.550039495653, 6002.459778619901, 6013.458788709037, 6026.608270462406, 6040.154378387029, 6042.909356359658, 5479.589030822664, 5482.122860342366, 5510.504054635102, 5519.917201241985, 5522.144067669517, 6604.3725846044545, 6698.665066746643, 6713.060171575983, 6717.932820671779, 6741.460683145337, 4499.055198408339, 4505.5719706627815, 4507.3689683444345, 4507.977460112711, 4508.053308805155, 6898.172219333662, 6966.442684585221, 6969.58182509051, 6979.546329488567, 6982.825429364307, 4559.863204103815, 4565.0, 4572.5198854119835, 4576.313552967015, 4582.725036497754, 4495.505494395614, 4552.954470455319, 4631.745254011062, 4631.814727410933, 4639.652026098056, 5406.2701535292235, 5411.783528658888, 5414.6480478769545, 5417.133258678671, 5434.375046869582, 6781.966090169616, 6787.083743694637, 6790.898136527956, 6791.151106111736, 6795.218549866829, 1642.8603568696794, 1649.2083799775935, 1650.488348611934, 1654.5780825889562, 1654.710425675502, 1044.8798388185455, 1051.9368837869752, 1061.5541472581535, 1063.1813503602184, 1074.0119090436817, 6517.446017088506, 6521.739130434825, 6524.575902566318, 6562.179727534059, 6660.83347916306, 7024.789256322319, 7073.929260707327, 7083.0, 7101.0, 7101.183363913216, 6611.20665520131, 6627.204735431779, 6635.270120286765, 6639.170103737033, 6644.867102658017, 3759.0978165240144, 3814.675752561008, 3838.3858582626644, 3843.442700808367, 3871.593482684334, 7326.194118646945, 7372.889406658905, 7375.9673645689645, 7383.630818459055, 7389.630518474162, 7243.529170603999, 7254.093238345207, 7267.30960558746, 7299.598522081336, 7309.744158954411, 7173.605451700102, 7320.487565870444, 7356.889646655304, 7398.223186565441, 7434.516756410816, 7082.929170708227, 7096.148462184365, 7100.857982840417, 7108.2536333686285, 7109.253528379446, 6859.691313890987, 6960.686769095504, 7011.474139439664, 7030.683619237045, 7034.859302814018, 7339.376153026839, 7356.926430735838, 7377.372923301579, 7397.926020739724, 7409.962950185214, 4514.751688657024, 4535.183666939983, 4546.249868771748, 4552.590266875997, 4583.0604726030415, 6774.085498457645, 6960.965195173992, 6962.164540254999, 6965.164180298397, 6972.9302706972285, 6813.8977915330315, 6817.761378351734, 6819.4544436443975, 6824.658767061528, 6829.214640316427, 6827.931720682928, 6829.760958366433, 6829.931700683128, 6836.0, 6838.2136054352395, 6454.806355809334, 6632.303608121078, 6648.601083934979, 6654.800355989328, 6676.899846502403, 6764.763233286812, 6794.184697836291, 6839.589624622538, 6872.518923675495, 6882.793516194522, 6698.5980841149685, 6723.2940541244425, 6731.596104233761, 6742.831429214113, 6763.7632682855865], "yui.html": [751.939844812415, 774.8798936164897, 785.5993443343895, 847.953362565059, 858.7080392666496, 14275.571732848031, 14287.499937502189, 14412.06321589096, 14469.782953255683, 14479.782803257945, 13441.26073065981, 13510.189388636689, 13521.59435216945, 13534.729305413886, 13540.458381664746, 668.5019660353043, 678.4368973751799, 808.6320724070563, 815.0586073085581, 826.0747962282252, 819.3895547816885, 820.3314298846451, 821.5563595658338, 830.8961379827522, 831.5592735849979, 858.8969323681135, 871.9754288710772, 873.2839071960994, 874.2306770042354, 874.4622057434696, 855.9529225892542, 860.8923884514436, 861.4745005546612, 862.7886167888845, 863.7020228021322, 638.7157714816908, 644.3395519592408, 645.106527459472, 645.6932956845508, 646.0309535696455, 12135.211211271238, 12201.0, 12261.203021803643, 12280.631581052583, 12322.507099716, 12407.379631018503, 13246.0, 13274.800877986838, 13362.331883405888, 13442.193468391928, 10272.435016074112, 10373.325733827278, 10442.2168337375, 10448.68653940383, 10474.738131546696, 3338.0820274424486, 3369.6461871503384, 3405.455127179664, 3487.19794447276, 3498.2303893143467, 45375.77312113418, 45677.858053548596, 45792.77103614527, 45927.0, 45942.310865337044, 5617.157426385993, 5717.313922329347, 5729.341125770507, 5833.183354330312, 5936.228290322317, 9098.272138228926, 9164.450132992042, 9198.862017069749, 9221.308401869886, 9240.722778316662, 6983.336583024605, 7061.752838650726, 7097.751578694721, 7102.325279098477, 7283.562986220843, 4316.7963522822765, 4324.762138082436, 4348.913021739548, 4366.628836548865, 4394.714343567658, 2806.9859650701615, 2819.746222839954, 2821.4498172856097, 2823.8729257183477, 2826.23691603266, 452.1228816096762, 454.06462686865166, 461.52462963148014, 462.09660114476117, 470.98351557695315, 681.3867519232631, 689.6791946776257, 707.5754547271699, 708.8334241453255, 752.1688534169773, 8890.511021893728, 9383.0, 9887.209023278265, 10019.899801002042, 10062.127905701167, 691.3604915453186, 707.264444977218, 718.6765955320127, 724.9565026098451, 747.8130467383154, 4000.179963107556, 4280.978595107004, 4313.805878735402, 4416.205083085011, 4475.888102797391, 62314.0652890207, 62824.0, 63245.0, 63351.683241583494, 63555.6822215886, 53208.20187697188, 53895.19157212645, 54260.45739542554, 54436.455635443934, 54495.45504544904, 48676.7566162174, 48841.75579122153, 48894.51105488899, 49238.75380623074, 49968.50031499711, 8611.827763444571, 8921.955390223267, 8960.820783584162, 8993.14565116313, 9016.18854303116, 34803.477947830295, 34973.82513087418, 35564.28871422609, 35593.82203088968, 36025.45961810627, 47273.29090063583, 47978.76010619925, 48038.59807009566, 48202.0, 48491.5150848487, 7527.2096429876265, 7577.431692622965, 8088.988876390451, 8297.669401595052, 8326.45878017927, 10254.948725256625, 10568.577256909637, 10642.73393165146, 10695.625653102104, 10719.678409647722, 11056.778864422828, 11190.104791616814, 11226.158038147334, 11295.322280663186, 11606.419679016184, 10808.89191108079, 10836.67489975302, 11082.556697732323, 11387.943060284646, 11510.82733759011, 10554.525046372779, 10955.616553420592, 11859.229150105215, 12217.69455763613, 12217.816732748837, 9244.861327079965, 9287.442753434816, 9307.86038209441, 9378.296627752808, 9900.356476828983, 8593.828123437372, 8943.0, 9065.637374504946, 9516.47659378713, 9729.221662267144]}, "summary": {"lowerIsBetter": false, "suite": 6768.5757243233475, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7138.88867984792, "unit": "ms", "value": 7138.88867984792}, "dojo.html": {"lowerIsBetter": false, "filtered": 5521.450231229902, "unit": "ms", "value": 5521.450231229902}, "mootools.html": {"lowerIsBetter": false, "filtered": 4388.932804368038, "unit": "ms", "value": 4388.932804368038}, "ext.html": {"lowerIsBetter": false, "filtered": 18195.05644631056, "unit": "ms", "value": 18195.05644631056}, "prototype.html": {"lowerIsBetter": false, "filtered": 5038.879425470797, "unit": "ms", "value": 5038.879425470797}, "yui.html": {"lowerIsBetter": false, "filtered": 6062.0361529826205, "unit": "ms", "value": 6062.0361529826205}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-017.e"}, "testrun": {"date": 1447721072, "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": "20151116143020", "branch": "Fx-Team", "revision": "2feb5677ea5cedb035700076148065deb08fb3aa"}}, {"talos_counters": {}, "results": {"audio-dft": [163.0, 162.0, 163.0, 163.0, 163.0, 163.0, 162.0, 166.0, 171.0, 163.0], "ai-astar": [112.0, 106.0, 110.0, 110.0, 113.0, 122.0, 109.0, 110.0, 109.0, 110.0], "imaging-gaussian-blur": [110.0, 110.0, 110.0, 110.0, 111.0, 109.0, 111.0, 111.0, 110.0, 110.0], "audio-beat-detection": [150.0, 124.0, 157.0, 177.0, 130.0, 152.0, 160.0, 129.0, 165.0, 129.0], "json-stringify-tinderbox": [69.0, 69.0, 69.0, 71.0, 70.0, 74.0, 70.0, 69.0, 70.0, 70.0], "stanford-crypto-pbkdf2": [145.0, 140.0, 162.0, 146.0, 150.0, 137.0, 146.0, 158.0, 145.0, 142.0], "json-parse-financial": [64.0, 60.0, 62.0, 61.0, 60.0, 65.0, 61.0, 61.0, 63.0, 59.0], "stanford-crypto-sha256-iterative": [66.0, 65.0, 66.0, 66.0, 68.0, 68.0, 65.0, 65.0, 66.0, 65.0], "audio-fft": [71.0, 73.0, 73.0, 72.0, 73.0, 73.0, 73.0, 130.0, 73.0, 81.0], "imaging-darkroom": [147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 148.0, 148.0, 147.0, 147.0], "stanford-crypto-ccm": [115.0, 119.0, 118.0, 126.0, 117.0, 124.0, 117.0, 123.0, 116.0, 138.0], "audio-oscillator": [89.0, 90.0, 139.0, 91.0, 91.0, 90.0, 139.0, 90.0, 91.0, 137.0], "stanford-crypto-aes": [84.0, 86.0, 87.0, 85.0, 86.0, 85.0, 85.0, 86.0, 86.0, 86.0], "imaging-desaturate": [96.0, 96.0, 96.0, 98.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1511.3999999999999, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 79.2, "unit": "ms", "value": 79.2}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 147.1, "unit": "ms", "value": 147.1}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 147.3, "unit": "ms", "value": 147.3}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 121.3, "unit": "ms", "value": 121.3}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 147.1, "unit": "ms", "value": 147.1}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 61.6, "unit": "ms", "value": 61.6}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 104.7, "unit": "ms", "value": 104.7}, "ai-astar": {"lowerIsBetter": true, "filtered": 111.1, "unit": "ms", "value": 111.1}, "audio-dft": {"lowerIsBetter": true, "filtered": 163.9, "unit": "ms", "value": 163.9}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 66.0, "unit": "ms", "value": 66.0}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 70.1, "unit": "ms", "value": 70.1}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 110.2, "unit": "ms", "value": 110.2}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.6, "unit": "ms", "value": 85.6}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.2, "unit": "ms", "value": 96.2}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-017.e"}, "testrun": {"date": 1447721072, "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": "20151116143020", "branch": "Fx-Team", "revision": "2feb5677ea5cedb035700076148065deb08fb3aa"}}, {"talos_counters": {}, "results": {"DeltaBlue": [194.62826002335538], "Encrypt": [284.4950213371266], "NavierStokes": [4845.410628019324], "Decrypt": [5045.226130653266], "Splay": [653.1678641410842], "Richards": [162.31131309852296], "RegExp": [25200.0], "Earley": [722.543352601156], "Boyer": [12132.530120481928], "RayTrace": [1058.2010582010582]}, "summary": {"lowerIsBetter": false, "suite": 21226.53270277897, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 339.714284, "unit": "score", "value": 339.714284}, "Encrypt": {"lowerIsBetter": false, "filtered": 935.6262149999995, "unit": "score", "value": 935.6262149999995}, "NavierStokes": {"lowerIsBetter": false, "filtered": 306.26919242273203, "unit": "score", "value": 306.26919242273203}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.75898306772911, "unit": "score", "value": 52.75898306772911}, "Splay": {"lowerIsBetter": false, "filtered": 124.76272099999996, "unit": "score", "value": 124.76272099999996}, "RegExp": {"lowerIsBetter": false, "filtered": 36.150198412698415, "unit": "score", "value": 36.150198412698415}, "Richards": {"lowerIsBetter": false, "filtered": 217.49562199999997, "unit": "score", "value": 217.49562199999997}, "Earley": {"lowerIsBetter": false, "filtered": 922.3847919999998, "unit": "score", "value": 922.3847919999998}, "Boyer": {"lowerIsBetter": false, "filtered": 54.93190566037737, "unit": "score", "value": 54.93190566037737}, "RayTrace": {"lowerIsBetter": false, "filtered": 699.2896049999997, "unit": "score", "value": 699.2896049999997}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-017.e"}, "testrun": {"date": 1447721072, "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": "20151116143020", "branch": "Fx-Team", "revision": "2feb5677ea5cedb035700076148065deb08fb3aa"}}] 17:04:42 INFO - RETURN: dromaeo_css: 6768.58 17:04:42 INFO - RETURN: kraken: 1511.40 17:04:42 INFO - RETURN: v8_7: 21226.53 17:04:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21226.53"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1511.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6768.58"}}} 17:04:42 INFO - Return code: 0 17:04:42 INFO - # TBPL SUCCESS # 17:04:42 INFO - Running post-action listener: _resource_record_post_action 17:04:42 INFO - Running post-run listener: _resource_record_post_run 17:04:44 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 4096; Write bytes: 507854848; Read time: 300; Write time: 493192 17:04:44 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 131567616; Read time: 0; Write time: 98556 17:04:44 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 4096; Write bytes: 306614272; Read time: 300; Write time: 277620 17:04:44 INFO - Running post-run listener: _upload_blobber_files 17:04:44 INFO - Blob upload gear active. 17:04:44 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:04:44 INFO - Copying logs to upload dir... 17:04:44 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1267.193969 ========= master_lag: 1.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-11-16 17:04:45.085524) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 17:04:45.090336) ========= 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=6587686cb2da90a5f91b3170000001be-1447719739.442651-1430312401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/JgTPEMinQ_iadziymxeNyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009237 build_url: 'https://queue.taskcluster.net/v1/task/JgTPEMinQ_iadziymxeNyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 17:04:45.119820) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 17:04:45.120220) ========= 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=6587686cb2da90a5f91b3170000001be-1447719739.442651-1430312401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004787 ========= master_lag: 0.38 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 17:04:45.508370) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 17:04:45.508719) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 17:04:45.509363) ========= ========= Total master_lag: 1.70 =========