builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1447954945.57 results: success (0) buildid: 20151119083115 builduid: e43a1f6daf2042f8b3ac3ff9a0c1360d revision: d052d9447bf90d0fedaae937afb76e672ca6d49b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:25.568474) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:25.568876) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:25.569368) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1447954897.489494-1700905094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006579 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:25.598352) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:25.598697) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:25.648006) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:25.648339) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1447954897.489494-1700905094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004615 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:25.705905) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:25.706244) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:25.706641) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:25.706933) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1447954897.489494-1700905094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-19 09:42:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.6M=0s 2015-11-19 09:42:26 (43.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.195267 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:25.923298) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:25.923756) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1447954897.489494-1700905094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015564 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:25.987223) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:25.987617) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d052d9447bf90d0fedaae937afb76e672ca6d49b --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 d052d9447bf90d0fedaae937afb76e672ca6d49b --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=0d7d1540fd7fba0c6b8b7f12000001dc-1447954897.489494-1700905094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-19 09:42:26,762 truncating revision to first 12 chars 2015-11-19 09:42:26,762 Setting DEBUG logging. 2015-11-19 09:42:26,762 attempt 1/10 2015-11-19 09:42:26,762 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d052d9447bf9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 09:42:27,013 unpacking tar archive at: fx-team-d052d9447bf9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.505727 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:26.507269) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:26.507579) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:26.515231) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:26.515535) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:26.515964) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 36 secs) (at 2015-11-19 09:42:26.516319) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0d7d1540fd7fba0c6b8b7f12000001dc-1447954897.489494-1700905094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:42:27 INFO - MultiFileLogger online at 20151119 09:42:27 in /builds/slave/test-pgo 09:42:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:42:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:42:27 INFO - {'append_to_log': False, 09:42:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:42:27 INFO - 'blob_upload_branch': 'Fx-Team', 09:42:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:42:27 INFO - 'branch': 'Fx-Team', 09:42:27 INFO - 'buildbot_json_path': 'buildprops.json', 09:42:27 INFO - 'config_files': ('talos/linux_config.py',), 09:42:27 INFO - 'default_actions': ('clobber', 09:42:27 INFO - 'read-buildbot-config', 09:42:27 INFO - 'download-and-extract', 09:42:27 INFO - 'populate-webroot', 09:42:27 INFO - 'create-virtualenv', 09:42:27 INFO - 'install', 09:42:27 INFO - 'run-tests'), 09:42:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:42:27 INFO - 'download_minidump_stackwalk': True, 09:42:27 INFO - 'download_symbols': 'ondemand', 09:42:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:42:27 INFO - 'tooltool.py': '/tools/tooltool.py', 09:42:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:42:27 INFO - '/tools/misc-python/virtualenv.py')}, 09:42:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:42:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:42:27 INFO - 'installer_path': 'installer.exe', 09:42:27 INFO - 'log_level': 'info', 09:42:27 INFO - 'log_name': 'talos', 09:42:27 INFO - 'log_to_console': True, 09:42:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:42:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:42:27 INFO - 'opt_config_files': (), 09:42:27 INFO - 'pip_index': False, 09:42:27 INFO - 'sps_profile': False, 09:42:27 INFO - 'sps_profile_interval': 0, 09:42:27 INFO - 'suite': 'dromaeojs', 09:42:27 INFO - 'system_bits': '64', 09:42:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:42:27 INFO - 'title': 'talos-linux64-ix-035', 09:42:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:42:27 INFO - 'use_talos_json': True, 09:42:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:42:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:42:27 INFO - 'work_dir': 'build'} 09:42:27 INFO - ##### 09:42:27 INFO - ##### Running clobber step. 09:42:27 INFO - ##### 09:42:27 INFO - Running pre-action listener: _resource_record_pre_action 09:42:27 INFO - Running main action method: clobber 09:42:27 INFO - rmtree: /builds/slave/test-pgo/build 09:42:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:42:28 INFO - Running post-action listener: _resource_record_post_action 09:42:28 INFO - ##### 09:42:28 INFO - ##### Running read-buildbot-config step. 09:42:28 INFO - ##### 09:42:28 INFO - Running pre-action listener: _resource_record_pre_action 09:42:28 INFO - Running main action method: read_buildbot_config 09:42:28 INFO - Using buildbot properties: 09:42:28 INFO - { 09:42:28 INFO - "properties": { 09:42:28 INFO - "buildnumber": 793, 09:42:28 INFO - "product": "firefox", 09:42:28 INFO - "script_repo_revision": "production", 09:42:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:42:28 INFO - "repository": "", 09:42:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 09:42:28 INFO - "buildid": "20151119083115", 09:42:28 INFO - "slavename": "talos-linux64-ix-035", 09:42:28 INFO - "pgo_build": "True", 09:42:28 INFO - "basedir": "/builds/slave/test-pgo", 09:42:28 INFO - "project": "", 09:42:28 INFO - "platform": "ubuntu64_hw", 09:42:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:42:28 INFO - "slavebuilddir": "test", 09:42:28 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 09:42:28 INFO - "branch": "fx-team", 09:42:28 INFO - "repo_path": "integration/fx-team", 09:42:28 INFO - "stage_platform": "linux64-pgo", 09:42:28 INFO - "builduid": "e43a1f6daf2042f8b3ac3ff9a0c1360d", 09:42:28 INFO - "revision": "d052d9447bf90d0fedaae937afb76e672ca6d49b" 09:42:28 INFO - }, 09:42:28 INFO - "sourcestamp": { 09:42:28 INFO - "repository": "", 09:42:28 INFO - "hasPatch": false, 09:42:28 INFO - "project": "", 09:42:28 INFO - "branch": "fx-team-linux64-pgo-talos", 09:42:28 INFO - "changes": [ 09:42:28 INFO - { 09:42:28 INFO - "category": null, 09:42:28 INFO - "files": [ 09:42:28 INFO - { 09:42:28 INFO - "url": null, 09:42:28 INFO - "name": "https://queue.taskcluster.net/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:42:28 INFO - } 09:42:28 INFO - ], 09:42:28 INFO - "repository": "", 09:42:28 INFO - "rev": "d052d9447bf90d0fedaae937afb76e672ca6d49b", 09:42:28 INFO - "who": "sendchange", 09:42:28 INFO - "when": 1447954913, 09:42:28 INFO - "number": 6683950, 09:42:28 INFO - "comments": "", 09:42:28 INFO - "project": "", 09:42:28 INFO - "at": "Thu 19 Nov 2015 09:41:53", 09:42:28 INFO - "branch": "fx-team-linux64-pgo-talos", 09:42:28 INFO - "revlink": "", 09:42:28 INFO - "properties": [ 09:42:28 INFO - [ 09:42:28 INFO - "buildid", 09:42:28 INFO - "20151119083115", 09:42:28 INFO - "Change" 09:42:28 INFO - ], 09:42:28 INFO - [ 09:42:28 INFO - "builduid", 09:42:28 INFO - "e43a1f6daf2042f8b3ac3ff9a0c1360d", 09:42:28 INFO - "Change" 09:42:28 INFO - ], 09:42:28 INFO - [ 09:42:28 INFO - "pgo_build", 09:42:28 INFO - "True", 09:42:28 INFO - "Change" 09:42:28 INFO - ] 09:42:28 INFO - ], 09:42:28 INFO - "revision": "d052d9447bf90d0fedaae937afb76e672ca6d49b" 09:42:28 INFO - } 09:42:28 INFO - ], 09:42:28 INFO - "revision": "d052d9447bf90d0fedaae937afb76e672ca6d49b" 09:42:28 INFO - } 09:42:28 INFO - } 09:42:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:42:28 INFO - Running post-action listener: _resource_record_post_action 09:42:28 INFO - ##### 09:42:28 INFO - ##### Running download-and-extract step. 09:42:28 INFO - ##### 09:42:28 INFO - Running pre-action listener: _resource_record_pre_action 09:42:28 INFO - Running main action method: download_and_extract 09:42:28 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:42:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:28 INFO - https://queue.taskcluster.net/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:42:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/test_packages.json 09:42:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/test_packages.json 09:42:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:42:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:42:51 INFO - Downloaded 1302 bytes. 09:42:51 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:42:51 INFO - Using the following test package requirements: 09:42:51 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:42:51 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:42:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:42:51 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:42:51 INFO - u'jsshell-linux-x86_64.zip'], 09:42:51 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:42:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:42:51 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:42:51 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:42:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:42:51 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:42:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:42:51 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:42:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:42:51 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:42:51 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:42:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:42:51 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:42:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:51 INFO - https://queue.taskcluster.net/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:42:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:42:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:42:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/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 09:42:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/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 09:42:54 INFO - Downloaded 22520742 bytes. 09:42:54 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 09:42:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:42:54 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 09:42:55 INFO - Return code: 0 09:42:55 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 09:42:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:55 INFO - https://queue.taskcluster.net/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:42:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:42:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:42:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/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 09:42:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/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 09:43:08 INFO - Downloaded 22520742 bytes. 09:43:08 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 09:43:08 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:43:08 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 09:43:09 INFO - Return code: 0 09:43:09 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')]} 09:43:09 INFO - https://queue.taskcluster.net/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:43:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:43:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:43:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/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 09:43:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/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 09:43:10 INFO - Downloaded 11130997 bytes. 09:43:10 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 09:43:10 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:43:10 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 09:43:10 INFO - Return code: 0 09:43:10 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')]} 09:43:10 INFO - https://queue.taskcluster.net/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:43:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:43:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:43:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/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 09:43:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/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 09:43:12 INFO - Downloaded 57346257 bytes. 09:43:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:43:12 INFO - mkdir: /builds/slave/test-pgo/properties 09:43:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:43:12 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:43:12 INFO - Contents: 09:43:12 INFO - build_url:https://queue.taskcluster.net/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:43:12 INFO - Running post-action listener: _resource_record_post_action 09:43:12 INFO - Running post-action listener: set_extra_try_arguments 09:43:12 INFO - ##### 09:43:12 INFO - ##### Running populate-webroot step. 09:43:12 INFO - ##### 09:43:12 INFO - Running pre-action listener: _resource_record_pre_action 09:43:12 INFO - Running main action method: populate_webroot 09:43:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:43:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:43:12 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:43:12 INFO - '../fennec_ids.txt'], 09:43:12 INFO - 'tests': ['tcheck2']}, 09:43:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:43:12 INFO - '--tppagecycles', 09:43:12 INFO - '7'], 09:43:12 INFO - 'tests': ['tsvgm']}}, 09:43:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:43:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:43:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:43:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:43:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:43:12 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:43:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:43:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:12 INFO - 'talos_options': ['--e10s'], 09:43:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:43:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:12 INFO - 'tests': ['damp', 'tps']}, 09:43:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:12 INFO - 'talos_options': ['--e10s'], 09:43:12 INFO - 'tests': ['damp', 'tps']}, 09:43:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:43:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:43:12 INFO - 'other': {'tests': ['a11yr', 09:43:12 INFO - 'ts_paint', 09:43:12 INFO - 'tpaint', 09:43:12 INFO - 'sessionrestore', 09:43:12 INFO - 'sessionrestore_no_auto_restore']}, 09:43:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:43:12 INFO - 'tests': ['a11yr', 09:43:12 INFO - 'ts_paint', 09:43:12 INFO - 'tpaint', 09:43:12 INFO - 'sessionrestore', 09:43:12 INFO - 'sessionrestore_no_auto_restore']}, 09:43:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:43:12 INFO - 'tests': ['a11yr', 09:43:12 INFO - 'ts_paint', 09:43:12 INFO - 'tpaint', 09:43:12 INFO - 'sessionrestore', 09:43:12 INFO - 'sessionrestore_no_auto_restore']}, 09:43:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:43:12 INFO - 'tests': ['a11yr', 09:43:12 INFO - 'ts_paint', 09:43:12 INFO - 'tpaint', 09:43:12 INFO - 'sessionrestore', 09:43:12 INFO - 'sessionrestore_no_auto_restore']}, 09:43:12 INFO - 'other_l64': {'tests': ['a11yr', 09:43:12 INFO - 'ts_paint', 09:43:12 INFO - 'tpaint', 09:43:12 INFO - 'sessionrestore', 09:43:12 INFO - 'sessionrestore_no_auto_restore']}, 09:43:12 INFO - 'other_nol64': {'tests': ['a11yr', 09:43:12 INFO - 'ts_paint', 09:43:12 INFO - 'tpaint', 09:43:12 INFO - 'sessionrestore', 09:43:12 INFO - 'sessionrestore_no_auto_restore']}, 09:43:12 INFO - 'svgr': {'tests': ['tsvgx', 09:43:12 INFO - 'tsvgr_opacity', 09:43:12 INFO - 'tart', 09:43:12 INFO - 'tscrollx', 09:43:12 INFO - 'cart']}, 09:43:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:43:12 INFO - 'tests': ['tsvgx', 09:43:12 INFO - 'tsvgr_opacity', 09:43:12 INFO - 'tart', 09:43:12 INFO - 'tscrollx', 09:43:12 INFO - 'cart']}, 09:43:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:12 INFO - 'tests': ['tp5o']}, 09:43:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:12 INFO - 'talos_options': ['--e10s'], 09:43:12 INFO - 'tests': ['tp5o']}, 09:43:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:12 INFO - 'talos_options': ['--xperf_path', 09:43:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:43:12 INFO - 'tests': ['tp5n']}, 09:43:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:12 INFO - 'talos_options': ['--e10s', 09:43:12 INFO - '--xperf_path', 09:43:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:43:12 INFO - 'tests': ['tp5n']}}, 09:43:12 INFO - 'talos.zip': {'path': '', 09:43:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:43:12 INFO - Running post-action listener: _resource_record_post_action 09:43:12 INFO - ##### 09:43:12 INFO - ##### Running create-virtualenv step. 09:43:12 INFO - ##### 09:43:12 INFO - Running pre-action listener: _resource_record_pre_action 09:43:12 INFO - Running main action method: create_virtualenv 09:43:12 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:43:12 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 09:43:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:43:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:43:12 INFO - Using real prefix '/usr' 09:43:12 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:43:13 INFO - Installing distribute.............................................................................................................................................................................................done. 09:43:15 INFO - Installing pip.................done. 09:43:15 INFO - Return code: 0 09:43:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:43:15 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')]} 09:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:15 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')]} 09:43:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:15 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 0x7fc8748f6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18996c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194b7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198fd70>, '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 0x1990b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1990fb0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1447954897.489494-1700905094', '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 09:43:15 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 09:43:15 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 09:43:15 INFO - Using env: {'DISPLAY': ':0', 09:43:15 INFO - 'HOME': '/home/cltbld', 09:43:15 INFO - 'LANG': 'en_US.UTF-8', 09:43:15 INFO - 'LANGUAGE': 'en_US:en', 09:43:15 INFO - 'LOGNAME': 'cltbld', 09:43:15 INFO - 'MAIL': '/var/mail/cltbld', 09:43:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:15 INFO - 'MOZ_NO_REMOTE': '1', 09:43:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:15 INFO - 'NO_EM_RESTART': '1', 09:43:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:43:15 INFO - 'PWD': '/builds/slave/test-pgo', 09:43:15 INFO - 'SHELL': '/bin/bash', 09:43:15 INFO - 'SHLVL': '1', 09:43:15 INFO - 'TERM': 'linux', 09:43:15 INFO - 'TMOUT': '86400', 09:43:15 INFO - 'USER': 'cltbld', 09:43:15 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1447954897.489494-1700905094', 09:43:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:15 INFO - '_': '/tools/buildbot/bin/python'} 09:43:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:15 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 09:43:15 INFO - Cleaning up... 09:43:15 INFO - Return code: 0 09:43:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:43:15 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')]} 09:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:15 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')]} 09:43:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:15 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 0x7fc8748f6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18996c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194b7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198fd70>, '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 0x1990b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1990fb0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1447954897.489494-1700905094', '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 09:43:15 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 09:43:15 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 09:43:15 INFO - Using env: {'DISPLAY': ':0', 09:43:15 INFO - 'HOME': '/home/cltbld', 09:43:15 INFO - 'LANG': 'en_US.UTF-8', 09:43:15 INFO - 'LANGUAGE': 'en_US:en', 09:43:15 INFO - 'LOGNAME': 'cltbld', 09:43:15 INFO - 'MAIL': '/var/mail/cltbld', 09:43:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:15 INFO - 'MOZ_NO_REMOTE': '1', 09:43:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:15 INFO - 'NO_EM_RESTART': '1', 09:43:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:43:15 INFO - 'PWD': '/builds/slave/test-pgo', 09:43:15 INFO - 'SHELL': '/bin/bash', 09:43:15 INFO - 'SHLVL': '1', 09:43:15 INFO - 'TERM': 'linux', 09:43:15 INFO - 'TMOUT': '86400', 09:43:15 INFO - 'USER': 'cltbld', 09:43:15 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1447954897.489494-1700905094', 09:43:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:15 INFO - '_': '/tools/buildbot/bin/python'} 09:43:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:15 INFO - Downloading/unpacking psutil>=0.7.1 09:43: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 09:43: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 09:43: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 09:43: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 09:43: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 09:43: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 09:43:17 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 09:43:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:43:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:43:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:43:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:43:17 INFO - Installing collected packages: psutil 09:43:17 INFO - Running setup.py install for psutil 09:43:17 INFO - building 'psutil._psutil_linux' extension 09:43:17 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 09:43:17 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 09:43:17 INFO - building 'psutil._psutil_posix' extension 09:43:17 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 09:43:17 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 09:43:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:43:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:43:17 INFO - Successfully installed psutil 09:43:17 INFO - Cleaning up... 09:43:17 INFO - Return code: 0 09:43:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:43: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')]} 09:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43: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')]} 09:43:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43: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', '--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 0x7fc8748f6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18996c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194b7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198fd70>, '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 0x1990b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1990fb0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1447954897.489494-1700905094', '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 09:43:17 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 09:43:17 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 09:43:17 INFO - Using env: {'DISPLAY': ':0', 09:43:17 INFO - 'HOME': '/home/cltbld', 09:43:17 INFO - 'LANG': 'en_US.UTF-8', 09:43:17 INFO - 'LANGUAGE': 'en_US:en', 09:43:17 INFO - 'LOGNAME': 'cltbld', 09:43:17 INFO - 'MAIL': '/var/mail/cltbld', 09:43:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:17 INFO - 'MOZ_NO_REMOTE': '1', 09:43:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:17 INFO - 'NO_EM_RESTART': '1', 09:43:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:43:17 INFO - 'PWD': '/builds/slave/test-pgo', 09:43:17 INFO - 'SHELL': '/bin/bash', 09:43:17 INFO - 'SHLVL': '1', 09:43:17 INFO - 'TERM': 'linux', 09:43:17 INFO - 'TMOUT': '86400', 09:43:17 INFO - 'USER': 'cltbld', 09:43:17 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1447954897.489494-1700905094', 09:43:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:17 INFO - '_': '/tools/buildbot/bin/python'} 09:43:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:43:18 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 09:43:18 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 09:43:18 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 09:43:18 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 09:43:18 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 09:43:18 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 09:43:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:43:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:43:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:43:19 INFO - Installing collected packages: mozsystemmonitor 09:43:19 INFO - Running setup.py install for mozsystemmonitor 09:43:19 INFO - Successfully installed mozsystemmonitor 09:43:19 INFO - Cleaning up... 09:43:20 INFO - Return code: 0 09:43:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:43:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:20 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 0x7fc8748f6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18996c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194b7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198fd70>, '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 0x1990b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1990fb0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1447954897.489494-1700905094', '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 09:43:20 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 09:43:20 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 09:43:20 INFO - Using env: {'DISPLAY': ':0', 09:43:20 INFO - 'HOME': '/home/cltbld', 09:43:20 INFO - 'LANG': 'en_US.UTF-8', 09:43:20 INFO - 'LANGUAGE': 'en_US:en', 09:43:20 INFO - 'LOGNAME': 'cltbld', 09:43:20 INFO - 'MAIL': '/var/mail/cltbld', 09:43:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:20 INFO - 'MOZ_NO_REMOTE': '1', 09:43:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:20 INFO - 'NO_EM_RESTART': '1', 09:43:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:43:20 INFO - 'PWD': '/builds/slave/test-pgo', 09:43:20 INFO - 'SHELL': '/bin/bash', 09:43:20 INFO - 'SHLVL': '1', 09:43:20 INFO - 'TERM': 'linux', 09:43:20 INFO - 'TMOUT': '86400', 09:43:20 INFO - 'USER': 'cltbld', 09:43:20 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1447954897.489494-1700905094', 09:43:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:20 INFO - '_': '/tools/buildbot/bin/python'} 09:43:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:20 INFO - Downloading/unpacking blobuploader==1.2.4 09:43:20 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 09:43:20 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 09:43:20 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 09:43:20 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 09:43:20 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 09:43:20 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 09:43:21 INFO - Downloading blobuploader-1.2.4.tar.gz 09:43:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:43:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:43:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:43:22 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 09:43:22 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 09:43:22 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 09:43:22 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 09:43:22 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 09:43:22 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 09:43:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:43:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:43:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:43:22 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 09:43:22 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 09:43:22 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 09:43:22 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 09:43:22 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 09:43:22 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 09:43:22 INFO - Downloading docopt-0.6.1.tar.gz 09:43:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:43:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:43:22 INFO - Installing collected packages: blobuploader, requests, docopt 09:43:22 INFO - Running setup.py install for blobuploader 09:43:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:43:22 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:43:22 INFO - Running setup.py install for requests 09:43:23 INFO - Running setup.py install for docopt 09:43:23 INFO - Successfully installed blobuploader requests docopt 09:43:23 INFO - Cleaning up... 09:43:23 INFO - Return code: 0 09:43:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:43:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:23 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 0x7fc8748f6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18996c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194b7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198fd70>, '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 0x1990b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1990fb0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1447954897.489494-1700905094', '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 09:43:23 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 09:43:23 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 09:43:23 INFO - Using env: {'DISPLAY': ':0', 09:43:23 INFO - 'HOME': '/home/cltbld', 09:43:23 INFO - 'LANG': 'en_US.UTF-8', 09:43:23 INFO - 'LANGUAGE': 'en_US:en', 09:43:23 INFO - 'LOGNAME': 'cltbld', 09:43:23 INFO - 'MAIL': '/var/mail/cltbld', 09:43:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:23 INFO - 'MOZ_NO_REMOTE': '1', 09:43:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:23 INFO - 'NO_EM_RESTART': '1', 09:43:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:43:23 INFO - 'PWD': '/builds/slave/test-pgo', 09:43:23 INFO - 'SHELL': '/bin/bash', 09:43:23 INFO - 'SHLVL': '1', 09:43:23 INFO - 'TERM': 'linux', 09:43:23 INFO - 'TMOUT': '86400', 09:43:23 INFO - 'USER': 'cltbld', 09:43:23 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1447954897.489494-1700905094', 09:43:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:23 INFO - '_': '/tools/buildbot/bin/python'} 09:43:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:43:23 INFO - Running setup.py (path:/tmp/pip-sUiSMC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:43:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:43:23 INFO - Running setup.py (path:/tmp/pip-7fD0iS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:43:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:43:23 INFO - Running setup.py (path:/tmp/pip-COoN_T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:43:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:43:23 INFO - Running setup.py (path:/tmp/pip-RV_KGB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:43:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:43:23 INFO - Running setup.py (path:/tmp/pip-5_K0T5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:43:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:43:23 INFO - Running setup.py (path:/tmp/pip-YElVo0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:43:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:43:23 INFO - Running setup.py (path:/tmp/pip-gXsei6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:43:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:43:23 INFO - Running setup.py (path:/tmp/pip-XZL0VT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:43:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:43:24 INFO - Running setup.py (path:/tmp/pip-jYgOyB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:43:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:43:24 INFO - Running setup.py (path:/tmp/pip-zZdfMv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:43:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:43:24 INFO - Running setup.py (path:/tmp/pip-dUXJ8F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:43:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:43:24 INFO - Running setup.py (path:/tmp/pip-dgkJeC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:43:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:43:24 INFO - Running setup.py (path:/tmp/pip-Re4UZ9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:43:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:43:24 INFO - Running setup.py (path:/tmp/pip-KcK8sE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:43:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:43:24 INFO - Running setup.py (path:/tmp/pip-cYZ5Fu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:43:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:43:24 INFO - Running setup.py (path:/tmp/pip-EiwmLz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:43:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:43:24 INFO - Running setup.py (path:/tmp/pip-htviS5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:43:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:43:24 INFO - Running setup.py install for manifestparser 09:43:24 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:43:24 INFO - Running setup.py install for mozcrash 09:43:24 INFO - Running setup.py install for mozdebug 09:43:24 INFO - Running setup.py install for mozdevice 09:43:25 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:43:25 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:43:25 INFO - Running setup.py install for mozfile 09:43:25 INFO - Running setup.py install for mozhttpd 09:43:25 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:43:25 INFO - Running setup.py install for mozinfo 09:43:25 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:43:25 INFO - Running setup.py install for mozInstall 09:43:25 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:43:25 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:43:25 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:43:25 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:43:25 INFO - Running setup.py install for mozleak 09:43:25 INFO - Running setup.py install for mozlog 09:43:25 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:43:25 INFO - Running setup.py install for moznetwork 09:43:25 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:43:25 INFO - Running setup.py install for mozprocess 09:43:25 INFO - Running setup.py install for mozprofile 09:43:25 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:43:25 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:43:25 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:43:26 INFO - Running setup.py install for mozrunner 09:43:26 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:43:26 INFO - Running setup.py install for mozscreenshot 09:43:26 INFO - Running setup.py install for moztest 09:43:26 INFO - Running setup.py install for mozversion 09:43:26 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:43:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:43:26 INFO - Cleaning up... 09:43:26 INFO - Return code: 0 09:43:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:43:26 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')]} 09:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:26 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')]} 09:43:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:26 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 0x7fc8748f6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18996c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194b7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198fd70>, '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 0x1990b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1990fb0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1447954897.489494-1700905094', '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 09:43:26 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 09:43:26 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 09:43:26 INFO - Using env: {'DISPLAY': ':0', 09:43:26 INFO - 'HOME': '/home/cltbld', 09:43:26 INFO - 'LANG': 'en_US.UTF-8', 09:43:26 INFO - 'LANGUAGE': 'en_US:en', 09:43:26 INFO - 'LOGNAME': 'cltbld', 09:43:26 INFO - 'MAIL': '/var/mail/cltbld', 09:43:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:26 INFO - 'MOZ_NO_REMOTE': '1', 09:43:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:26 INFO - 'NO_EM_RESTART': '1', 09:43:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:43:26 INFO - 'PWD': '/builds/slave/test-pgo', 09:43:26 INFO - 'SHELL': '/bin/bash', 09:43:26 INFO - 'SHLVL': '1', 09:43:26 INFO - 'TERM': 'linux', 09:43:26 INFO - 'TMOUT': '86400', 09:43:26 INFO - 'USER': 'cltbld', 09:43:26 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1447954897.489494-1700905094', 09:43:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:26 INFO - '_': '/tools/buildbot/bin/python'} 09:43:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:43:26 INFO - Running setup.py (path:/tmp/pip-X2hfzr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:43:26 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)) 09:43:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:43:26 INFO - Running setup.py (path:/tmp/pip-avmLFi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:43:26 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)) 09:43:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:43:26 INFO - Running setup.py (path:/tmp/pip-vEtGmn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:43:26 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)) 09:43:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:43:26 INFO - Running setup.py (path:/tmp/pip-KPy98x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:43:26 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)) 09:43:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:43:26 INFO - Running setup.py (path:/tmp/pip-ql5Wht-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:43:27 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)) 09:43:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:43:27 INFO - Running setup.py (path:/tmp/pip-gnzScV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:43:27 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)) 09:43:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:43:27 INFO - Running setup.py (path:/tmp/pip-YZCMrv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:43:27 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)) 09:43:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:43:27 INFO - Running setup.py (path:/tmp/pip-IjAsHg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:43:27 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)) 09:43:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:43:27 INFO - Running setup.py (path:/tmp/pip-hl9Rce-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:43:27 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)) 09:43:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:43:27 INFO - Running setup.py (path:/tmp/pip-phN27X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:43:27 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)) 09:43:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:43:27 INFO - Running setup.py (path:/tmp/pip-U1HLYo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:43:27 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)) 09:43:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:43:27 INFO - Running setup.py (path:/tmp/pip-cIJcD_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:43:27 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)) 09:43:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:43:27 INFO - Running setup.py (path:/tmp/pip-xbadd5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:43:27 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)) 09:43:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:43:27 INFO - Running setup.py (path:/tmp/pip-PIEVVQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:43:27 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)) 09:43:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:43:27 INFO - Running setup.py (path:/tmp/pip-DebQxh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:43:27 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)) 09:43:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:43:27 INFO - Running setup.py (path:/tmp/pip-vg7H7T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:43:27 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)) 09:43:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:43:27 INFO - Running setup.py (path:/tmp/pip-cnETcX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:43:27 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)) 09:43:27 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)) 09:43:27 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)) 09:43:27 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)) 09:43:27 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)) 09:43:27 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)) 09:43:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:43:27 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 09:43:27 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 09:43:27 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 09:43:27 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 09:43:27 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 09:43:27 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 09:43:29 INFO - Downloading blessings-1.5.1.tar.gz 09:43:29 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 09:43:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:43:29 INFO - Installing collected packages: blessings 09:43:29 INFO - Running setup.py install for blessings 09:43:29 INFO - Successfully installed blessings 09:43:29 INFO - Cleaning up... 09:43:29 INFO - Return code: 0 09:43:29 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:43:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:43:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:43:30 INFO - Reading from file tmpfile_stdout 09:43:30 INFO - Current package versions: 09:43:30 INFO - argparse == 1.2.1 09:43:30 INFO - blessings == 1.5.1 09:43:30 INFO - blobuploader == 1.2.4 09:43:30 INFO - docopt == 0.6.1 09:43:30 INFO - manifestparser == 1.1 09:43:30 INFO - mozInstall == 1.12 09:43:30 INFO - mozcrash == 0.16 09:43:30 INFO - mozdebug == 0.1 09:43:30 INFO - mozdevice == 0.47 09:43:30 INFO - mozfile == 1.2 09:43:30 INFO - mozhttpd == 0.7 09:43:30 INFO - mozinfo == 0.9 09:43:30 INFO - mozleak == 0.1 09:43:30 INFO - mozlog == 3.0 09:43:30 INFO - moznetwork == 0.27 09:43:30 INFO - mozprocess == 0.22 09:43:30 INFO - mozprofile == 0.27 09:43:30 INFO - mozrunner == 6.11 09:43:30 INFO - mozscreenshot == 0.1 09:43:30 INFO - mozsystemmonitor == 0.0 09:43:30 INFO - moztest == 0.7 09:43:30 INFO - mozversion == 1.4 09:43:30 INFO - psutil == 3.1.1 09:43:30 INFO - requests == 1.2.3 09:43:30 INFO - wsgiref == 0.1.2 09:43:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:43:30 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')]} 09:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:30 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')]} 09:43:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:30 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 0x7fc8748f6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18996c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194b7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198fd70>, '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 0x1990b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1990fb0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1447954897.489494-1700905094', '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 09:43:30 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 09:43:30 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 09:43:30 INFO - Using env: {'DISPLAY': ':0', 09:43:30 INFO - 'HOME': '/home/cltbld', 09:43:30 INFO - 'LANG': 'en_US.UTF-8', 09:43:30 INFO - 'LANGUAGE': 'en_US:en', 09:43:30 INFO - 'LOGNAME': 'cltbld', 09:43:30 INFO - 'MAIL': '/var/mail/cltbld', 09:43:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:30 INFO - 'MOZ_NO_REMOTE': '1', 09:43:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:30 INFO - 'NO_EM_RESTART': '1', 09:43:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:43:30 INFO - 'PWD': '/builds/slave/test-pgo', 09:43:30 INFO - 'SHELL': '/bin/bash', 09:43:30 INFO - 'SHLVL': '1', 09:43:30 INFO - 'TERM': 'linux', 09:43:30 INFO - 'TMOUT': '86400', 09:43:30 INFO - 'USER': 'cltbld', 09:43:30 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1447954897.489494-1700905094', 09:43:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:30 INFO - '_': '/tools/buildbot/bin/python'} 09:43:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:30 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)) 09:43:30 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)) 09:43:30 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)) 09:43:30 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)) 09:43:30 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)) 09:43:30 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)) 09:43:30 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)) 09:43:30 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)) 09:43:30 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)) 09:43:30 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)) 09:43:30 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)) 09:43:30 INFO - Cleaning up... 09:43:30 INFO - Return code: 0 09:43:30 INFO - Running post-action listener: _resource_record_post_action 09:43:30 INFO - Running post-action listener: _start_resource_monitoring 09:43:30 INFO - Starting resource monitoring. 09:43:30 INFO - ##### 09:43:30 INFO - ##### Running install step. 09:43:30 INFO - ##### 09:43:30 INFO - Running pre-action listener: _resource_record_pre_action 09:43:30 INFO - Running main action method: install 09:43:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:43:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:43:30 INFO - Reading from file tmpfile_stdout 09:43:30 INFO - Detecting whether we're running mozinstall >=1.0... 09:43:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:43:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:43:30 INFO - Reading from file tmpfile_stdout 09:43:30 INFO - Output received: 09:43:30 INFO - Usage: mozinstall [options] installer 09:43:30 INFO - Options: 09:43:30 INFO - -h, --help show this help message and exit 09:43:30 INFO - -d DEST, --destination=DEST 09:43:30 INFO - Directory to install application into. [default: 09:43:30 INFO - "/builds/slave/test-pgo"] 09:43:30 INFO - --app=APP Application being installed. [default: firefox] 09:43:30 INFO - mkdir: /builds/slave/test-pgo/build/application 09:43:30 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'] 09:43:30 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 09:43:45 INFO - Reading from file tmpfile_stdout 09:43:45 INFO - Output received: 09:43:45 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:43:45 INFO - Running post-action listener: _resource_record_post_action 09:43:45 INFO - ##### 09:43:45 INFO - ##### Running run-tests step. 09:43:45 INFO - ##### 09:43:45 INFO - Running pre-action listener: _resource_record_pre_action 09:43:45 INFO - Running main action method: run_tests 09:43:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:43:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:43:45 INFO - Python 2.7.3 09:43:45 INFO - Return code: 0 09:43:45 INFO - grabbing minidump binary from tooltool 09:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:45 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 0x198fd70>, '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 0x1990b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1990fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:43:45 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 09:43:45 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 09:43:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:43:45 INFO - Return code: 0 09:43:45 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:43:45 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:43:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:43:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:43:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:43:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 09:43:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost 09:43:45 INFO - Using env: {'DISPLAY': ':0', 09:43:45 INFO - 'HOME': '/home/cltbld', 09:43:45 INFO - 'LANG': 'en_US.UTF-8', 09:43:45 INFO - 'LANGUAGE': 'en_US:en', 09:43:45 INFO - 'LOGNAME': 'cltbld', 09:43:45 INFO - 'MAIL': '/var/mail/cltbld', 09:43:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:43:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:45 INFO - 'MOZ_NO_REMOTE': '1', 09:43:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:43:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:45 INFO - 'NO_EM_RESTART': '1', 09:43:45 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:43:45 INFO - 'PWD': '/builds/slave/test-pgo', 09:43:45 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:43:45 INFO - 'SHELL': '/bin/bash', 09:43:45 INFO - 'SHLVL': '1', 09:43:45 INFO - 'TERM': 'linux', 09:43:45 INFO - 'TMOUT': '86400', 09:43:45 INFO - 'USER': 'cltbld', 09:43:45 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1447954897.489494-1700905094', 09:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:45 INFO - '_': '/tools/buildbot/bin/python'} 09:43:45 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost'] with output_timeout 3600 09:43:45 INFO - mozversion INFO | application_buildid: 20151119083115 09:43:45 INFO - mozversion INFO | application_changeset: d052d9447bf90d0fedaae937afb76e672ca6d49b 09:43:45 INFO - mozversion INFO | application_display_name: Nightly 09:43:45 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:43:45 INFO - mozversion INFO | application_name: Firefox 09:43:45 INFO - mozversion INFO | application_remotingname: firefox 09:43:45 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 09:43:45 INFO - mozversion INFO | application_vendor: Mozilla 09:43:45 INFO - mozversion INFO | application_version: 45.0a1 09:43:45 INFO - mozversion INFO | platform_buildid: 20151119083115 09:43:45 INFO - mozversion INFO | platform_changeset: d052d9447bf90d0fedaae937afb76e672ca6d49b 09:43:45 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 09:43:45 INFO - mozversion INFO | platform_version: 45.0a1 09:43:45 INFO - 2015-11-19 09:43:45,371 DEBUG : using testdate: 1447955025 09:43:45 INFO - 2015-11-19 09:43:45,371 DEBUG : actual date: 1447955025 09:43:45 INFO - 2015-11-19 09:43:45,382 INFO : starting webserver on 'localhost:37630' 09:43:45 INFO - 2015-11-19 09:43:45,383 INFO : Starting test suite talos-linux64-ix-035 09:43:45 INFO - 2015-11-19 09:43:45,383 INFO : Starting test dromaeo_css 09:43:45 INFO - 2015-11-19 09:43:45,383 DEBUG : operating with platform_type : linux_ 09:43:45 INFO - 2015-11-19 09:43:45,384 INFO : Initialising browser for dromaeo_css test... 09:43:45 INFO - 2015-11-19 09:43:45,400 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJiid8K/profile http://localhost:37630/getInfo.html 09:43:49 INFO - 2015-11-19 09:43:49,403 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:43:49 INFO - 2015-11-19 09:43:49,403 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:43:49 INFO - 2015-11-19 09:43:49,403 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:43:49 INFO - 2015-11-19 09:43:49,403 DEBUG : BROWSER_OUTPUT: __metrics 09:43:49 INFO - 2015-11-19 09:43:49,525 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:43:50 INFO - 2015-11-19 09:43:50,870 INFO : Browser initialized. 09:43:50 INFO - 2015-11-19 09:43:50,871 INFO : Running cycle 1/1 for dromaeo_css test... 09:43:50 INFO - 2015-11-19 09:43:50,871 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJiid8K/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:44:02 INFO - 2015-11-19 09:44:02,707 DEBUG : BROWSER_OUTPUT: RSS: Main: 141598720 09:44:02 INFO - 2015-11-19 09:44:02,707 DEBUG : BROWSER_OUTPUT: 09:44:53 INFO - 2015-11-19 09:44:53,480 DEBUG : BROWSER_OUTPUT: 1447955093480 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] 09:47:03 INFO - 2015-11-19 09:47:03,467 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37630/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37630/tests/dromaeo/cssquery-ext.html) 09:47:04 INFO - 2015-11-19 09:47:04,820 DEBUG : BROWSER_OUTPUT: RSS: Main: 270819328 09:47:04 INFO - 2015-11-19 09:47:04,820 DEBUG : BROWSER_OUTPUT: 09:50:07 INFO - 2015-11-19 09:50:07,252 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37630/tests/dromaeo/cssquery-ext.html (next: http://localhost:37630/tests/dromaeo/cssquery-jquery.html) 09:50:07 INFO - 2015-11-19 09:50:07,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 216866816 09:50:07 INFO - 2015-11-19 09:50:07,818 DEBUG : BROWSER_OUTPUT: 09:53:09 INFO - 2015-11-19 09:53:09,654 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37630/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37630/tests/dromaeo/cssquery-mootools.html) 09:53:10 INFO - 2015-11-19 09:53:10,220 DEBUG : BROWSER_OUTPUT: RSS: Main: 210665472 09:53:10 INFO - 2015-11-19 09:53:10,220 DEBUG : BROWSER_OUTPUT: 09:56:12 INFO - 2015-11-19 09:56:12,124 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37630/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37630/tests/dromaeo/cssquery-prototype.html) 09:56:12 INFO - 2015-11-19 09:56:12,710 DEBUG : BROWSER_OUTPUT: RSS: Main: 196022272 09:56:12 INFO - 2015-11-19 09:56:12,710 DEBUG : BROWSER_OUTPUT: 09:59:15 INFO - 2015-11-19 09:59:15,236 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37630/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37630/tests/dromaeo/cssquery-yui.html) 09:59:15 INFO - 2015-11-19 09:59:15,803 DEBUG : BROWSER_OUTPUT: RSS: Main: 206323712 09:59:15 INFO - 2015-11-19 09:59:15,803 DEBUG : BROWSER_OUTPUT: 10:02:18 INFO - 2015-11-19 10:02:18,320 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37630/tests/dromaeo/cssquery-yui.html (next: http://localhost:37630/tests/dromaeo/cssquery-dojo.html) 10:02:18 INFO - 2015-11-19 10:02:18,571 DEBUG : BROWSER_OUTPUT: RSS: Main: 249815040 10:02:18 INFO - 2015-11-19 10:02:18,571 DEBUG : BROWSER_OUTPUT: 10:02:18 INFO - 2015-11-19 10:02:18,573 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:02:18 INFO - 2015-11-19 10:02:18,573 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:02:18 INFO - 2015-11-19 10:02:18,573 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:02:18 INFO - 2015-11-19 10:02:18,573 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:02:18 INFO - 2015-11-19 10:02:18,575 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3227.4190645683775;3288.8848890288814;3326.018824446788;3334.7665663403573;3345.6988871001604;5405.297311349529;5528.143137813645;5564.360098588659;5574.968630803299;5575.386707462176;5482.150266708657;5575.665460072389;5601.187827764982;5635.070213414781;5640.0693885508845;5048.495150484959;5065.797368105272;5088.84733457995;5090.440051594322;5117.385913690362;4873.1715608346485;5164.328637277149;5186.948130518703;5196.792128314863;5248.370195576517;4971.204607262821;4996.25056241563;5051.267566202917;5056.797728090872;5073.289739436482;5041.823536176216;5044.2937988681615;5044.722540260284;5050.242463630485;5087.211482220262;4940.308356830046;5010.3737032870895;5010.949890501085;5029.547340739351;5070;5356.11624082026;5457.972710136463;5459.153831156177;5486.725663716798;5510.862228444281;6036.879262414727;6036.909446358308;6037.154798328237;6044.667543285118;6045.727942242565;5792.913106303409;5937;5937.317208521033;6069.180660610805;6077;5581.190727344553;5637.68992705397;5639.492445679826;5641.830745077655;5700.629459085146;6078;6080.361562036011;6086.756529738761;6088.512918966472;6102.549845102896;5683.062294721325;5736.397678243808;5796.710164491758;5910.631648836556;5962.731677074542;5912.083627037816;5967.641941483438;6013.128096425994;6018.488428483628;6064.727087281083;5909.468147866713;5960.761569537257;5982.551308651869;5983.820485385445;5989.2812862456785;5806.332271788799;5916.349201587822;5916.911246331309;5963.701814909237;5969.910451343233;4535.183666939916;4573.725576465423;4577;4619.9076018479445;4629.421322334708;4036.1322315702264;4038.5961403859965;4047.170330082385;4073.7759423232005;4113.547509773923;5459.099248624012;5572.637778544382;5585.944140558542;5644.040513112781;5651.265335506358;5879.294484661782;5931.555133365015;5988.550858685616;5991.910121348184;6031.758729650853;5517.613767036269;5563.499285064283;5593.412691667398;5606.663600183921;5619.466150715675;4999.575036121898;5121.564667003272;5127.769250383742;5144;5146.356705411824;6099.050001489054;6251.562390632612;6258.123862659231;6261.843453913598;6264.342244064399;6081.331053584014;6097;6103.938960610337;6104.633721976696;6106.6336019838955;5946.791862284799;6014.909776353271;6085.939140608537;6241.282252541016;6261.937380626136;5929;6010.9699451502465;6017.037274036134;6021.217241758543;6068.302145253176;6016.488598469179;6065.211522502046;6066.696665166813;6066.848328791815;6071.241094863142;5689.715514224355;5856.970715146397;5868.559858010752;5929.436703513159;5936.851578710567;5798;5876.676782776988;5878.911816322673;5879.647221166743;5929.495992840657;5753.482186603226;5802.303723553201;5806.332271788799;5809.157672137601;5816.36020037804;5575.944240557543;5784.595078344475;5849.415058494116;5951.16683664296;5962.25471816023;5691.060974939089;5700.657960522382;5700.657960522382;5719.685417301922;5790.94209057904 10:02:18 INFO - 2015-11-19 10:02:18,576 DEBUG : BROWSER_OUTPUT: |1;ext.html;577.1717585265145;578.7164289498146;582.0570675505681;594.5451729426989;598.4225222660132;30943.38113237734;31599;31602.36795264096;31614;31625.051248462554;32030;32660;39218.60781392185;40001.59998400015;40015.19969600614;8656.394052416317;8795.296376289882;8798.120187981214;8806.075362086985;8810.603522841488;7848;8663.610137543794;8776.56117194141;8777.692780752675;8778.341624378165;7838.529688218697;10605.310654807452;10856.240063195579;10856.945715271451;10861.728456788604;10355.844662330072;10390.480475976246;10459.790804183875;10463.686089417291;10466.953304669549;7857.8035549111155;8062.637181326854;10186.185105191567;10330.380177189318;10497.317674351143;39387;39672.404913926315;39710.80144599258;39731.8013409934;39740.60259397427;3518.6305437928904;3792.924141517182;3819.866304679323;3899.298126337258;4129.648979836717;30529.847350763324;30983;31061.22346941322;31143.688563114305;31393.843030784927;3251.2735975531104;3272.6236482804543;3326.850291736878;3382.2897191589796;3448.620651728308;276135.6193219041;276435;276658;277161;277736;57022;57061;57167.42832571704;57235.713821430625;57371;61057.08414373788;61347.38652613506;61670.38329616736;61740.69129654413;61796;14986.40054397812;15200.391984320724;15357.462488812838;15409;15416.383344666088;11014.559417623366;11019.504122314514;11020.724481888017;11026.558937642405;11072.612458563912;18437;18705.158267877978;18706.71939920902;18880.716789247897;18891.14989825461;7198.604076775828;7381.630918454056;7463.776086717407;7527.9247207528315;7592.658330375147;882.3646974178581;905.5924833824805;944.9102335278137;1003.6838395905266;1043.909114974853;27976;28817.279568010967;29148.10065315754;29674.40651186964;29722.851385743365;964.8121494863296;966.4877614863992;1024.1294899335505;1031.9948400257952;1040.9902394677151;13830;13847.376868040761;13973.580792576238;14076.366563504667;14160.716785664228;322509;327058;327227;327407;328037;42035.36946945798;42503.149937001086;47003.529964700596;47291;47482.76258618685;1334.9332533373292;1335.8063080853221;1342.214804339453;1364.249662685519;1366.961109556724;23527;23808.761912380654;24552.386190345384;24710.629340560266;29504.26823508362;45325.773371132935;45522.772386137854;45658;45710.31434528418;45740;263669;265410;265714;265872;266820;29719.702802971693;29905.252368690955;29964;29969.100926972227;30276.84861575678;40831.38752918768;41385.37921931113;41443.17113657649;42200.15599687928;42488;34649.133771655914;35240.64759352374;35244.823775880956;35259.47110793392;35835.82082089573;35197.64802352046;35744.10639734028;36228.456573151954;36245.63754362422;36246.45630315495;34305.65694343125;34938;35004.299914001065;35009.29981400409;35242.295154097286;29930.25174370571;31485.527717083805;32104.357912841144;32291.838540808087;32459.837700811346;24782;25233.747662523874;25596;26175.869120654275;26264.21207363782 10:02:18 INFO - 2015-11-19 10:02:18,578 DEBUG : BROWSER_OUTPUT: |2;jquery.html;356.1790073879707;357.51378125748977;357.71919043550815;357.78710172515196;358.04045158973946;14260.500882469116;14412.783808242859;16403.589910252234;16711.749323760137;17414.303427862902;15579.298931548079;16344.264508097134;16732.83267167328;16758.497245082635;17058.744118838196;5277.973610131944;5419.430959749228;5423.159410291411;5423.566114710833;5424.321959755031;3783.886483405502;3882.495275614166;5341;5421.295231619883;5763.510101641345;5791.160281759164;5823.505002074829;5848.239728835267;5853.385394533577;5854.209681692981;5646.209530665689;5739.139129130643;5789.913151302734;5798.333191682968;5820.505257053155;5062.848114556569;5077.086124497589;5085.516875896784;5095.872603184913;5123.871903202413;19443.125059372363;19457.318993835288;19565.21739130433;20299.28952486656;20332.08505617251;1984.394759598322;2020.8080232377902;2030.7055476955907;2076.345951025422;2148.7743786902306;12509;12513.311767852765;12762.872371276262;12778.488860445572;12828.551000715024;1632.3470611755274;1643.5726711055092;1680.420255012019;1695.7456381542745;1780.7952085510074;59710.40289597092;60319.39680603226;60668.69665651688;61121.6943915282;61725.69137154285;6750.966245168743;6978.197507286727;6980.546264492792;7022.157341119098;7042.823929401703;8416.579171041423;8422;8422.24199822019;8424.705135320235;8438.620262088221;5402;5424.484673955968;5470.617056806065;5502.697351645698;5514.420985796514;5554.305711786027;5603.467670571289;5610.943890561124;5620.4660557247;5648.15277708347;3208.871645134215;3254.1213872254834;3271.2312606537444;3283.1463819407127;3292.3909076820864;1107.06453047175;1145.4272863568217;1157.4907040901976;1171.8183681529376;1196.1638884312713;413.6938665387652;417.651261196904;458.3537212530316;484.79638551808324;511.9436861945183;9890.901090989142;10718.839217411745;10784.56861725538;10798.94600527008;10880.836787448194;433.0300127713961;436.9565972998084;440.053884149082;447.6620151785381;458.06783196195585;5765.827025189251;5984.461398474158;5991.7902873399225;6036.275646922398;6088.908666370008;596629;598592;608797;609999;610362;58633;76557.61721191359;79342.61972140845;79901;80112.19887801047;471.2295397025819;476.25941660717916;478.23721164742875;479.4270846338662;481.1891962043897;9718.465484398426;9811.16605088547;9854.704358869245;9959.502024898871;9978.550965206437;34725.30549388948;34885.30229395347;35549.289014220085;35563.110922226115;36269;47054.76472617615;47776.5222347786;47824.52175478201;47952.7602361986;49413.75293123511;6677;6787.694553745192;6796.796096117125;6797.456203503807;6800.285969973082;11508.94245528767;11773.52905883755;11973.76052478928;12065.81901271464;12126.393680316125;10492.213084018882;10677.14582833387;10688.358698478116;10808.297460665031;10861.294015888941;10436.112930400697;10801.67594972152;10914.399708016135;10950.56197752081;10991.945040274748;10272.794544109225;10869.836952445561;11180.720481988015;11254;11266;6718.126643536309;6728.259891412039;6741.22475915276;6799.830004249933;6829.590224586541;10731.624393146203;10797.730056748644;10890.782184356427;11113.444327783416;11116.333020018825 10:02:18 INFO - 2015-11-19 10:02:18,579 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1311.468855113678;1430.835453922799;1501.0918394371406;1595.306041871786;1718.3556166437586;6634.635095069769;7519.6616152273145;7791.220877912206;7796.33731132853;7798.3761299096;7529.774106776806;7622.0853497580365;7622.77131686049;7632.503887247339;7638.045244344457;1968.0651690446994;2029.9391018269475;2034.2676636410881;2297.6783250344965;2320.408295884547;2311.6070268054473;2364.917227897024;2367.0886708617136;2368.3131891751373;2368.6328619064075;2295.758945310735;2306;2356.2577787996725;2356.599378105726;2359.091749676378;1968.4488343263909;2012.5572374077678;2293.059845463352;2336.8481048731865;2338.789508944203;2306.1351993002622;2309.6766452696634;2310.2145270608075;2318.1075286015007;2319.211468100854;7807.414443916672;7849.175836537195;7893.644785984645;7904.762857114296;7911.485753426009;4755.738434386108;4854.635902307341;4878.829240976549;4889.75551222441;4895.9755201224125;3135.247540590242;3158.273597072663;3191.457452233126;3202.1194171602997;3250.089974807058;1110.8500352452397;1788.4366424576217;1801.2434777393526;1845.1604519943394;1871.3543827379533;10525.21060920434;10626.30928989621;10676.145908327315;10705.999999999922;10718.303310284884;4194.580541945781;4248.277792775236;4309.956900430955;4313.374560688682;4316.330968699856;8779.429337093068;8783.560821958876;8797.868031979526;8816.603252853636;8818.735437936872;4804.8798780030775;4806.134895718735;4836.347093142451;4838.395200599925;4841.9031619367415;4453.576910193527;4455.1757924784015;4456.242438785414;4456.487503937024;4458.710183838105;3469.444888817777;3516.6659167379057;3525.206828463575;3548.8580456781438;3553.626869178751;1091.6888686724246;1109.2124591540096;1116.5422176907591;1133.2463911498926;1133.28602980122;1009.6869970309081;1016.0093908439212;1037.896210378971;1038.3250886923408;1170.8829117088223;6361.427471527585;7585.127710313274;7688.115866675292;7693.49992250502;7694.307512323806;704.0003195462456;704.7357241034612;735.8417940142788;735.9705611775576;738.759903031517;5769.307683078057;5781;5840.445157710011;5845.064789633639;5867.559933004956;9513.619455221851;9594.04059594035;9678.516074196263;9694.466804325688;9703.805923881482;9282.257419406431;9520.428774273565;9542.379745316532;9568.186704130088;9580.13778759901;7266.63666816657;7313;7315.231900650355;7320.780376588711;7323.414126869838;7025.156981162293;7109.111361079865;7119.964400177966;7143.4999550031;7425.368843648351;8182.81349204374;8445.366597505088;8464.95767521183;8484.872726908978;8510.31917446615;8428;8475;8592.65629374818;8666.35002374837;8711.477311361085;7129.500934934712;7186.640667966476;7192.388646965067;7199.460040497089;7202.135743710788;7632.427567932538;7702.460827742004;7734.651940662796;7743.29647477554;7752.30229279345;7096.7516136934955;7146.071010768567;7183.8563228736175;7278.708851646086;7369.336759691653;7093.432525398059;7108.573485590881;7132.928670713226;7236.565806051653;7307.488475806856;7253.492255542273;7293.0519032525435;7297.160826504807;7301.926980730124;7307.2327405621645;5523.944760552343;6157.722902469489;6632.867342653217;6672.399484046459;6690.765823196165;6692.866142677217;6697.7655782047395;6721.731130754911;6734.4612431004425;6736.393724564813 10:02:18 INFO - 2015-11-19 10:02:18,580 DEBUG : BROWSER_OUTPUT: |4;prototype.html;336.0506568942737;336.5641494264927;338.38582971906004;345.8720273498805;347.1148571143585;5836;5958.851028724284;5997.6401415915025;6010.909836352458;6048.909266360997;5812.360640329561;5940.34656187819;5953.58324917256;5958.136070269808;5960.22517072781;4590.265557510799;4621.214393553088;4636;4636.698614590041;4663.2538793793;4452.243118669834;4536.818527258923;4540.523245059271;4647.8838029049375;4660.019491716024;4561.224591819382;4566.680332376735;4584.472785629662;4598.126355992367;4612.723236605798;4575.4051973243595;4580.381648477446;4591.1965406053805;4609.492955774862;4621.838235661769;4058.655014323786;4062.329715596923;4062.350023996176;4067.3695577185586;4067.779666100158;5581.358143813432;5632.04255276604;5651.886962260732;5664.54683625309;5670.064439367499;5361.731913404353;5368.32895888014;5373.892522149574;5375.623706340558;5378.354597448292;6070.119832624245;6328.557001009931;6332.461740752042;6334.714937827763;6337.588056776295;4352.086061926999;4417.536158703322;4487.461504619434;4491.23648979671;4496.2581174106235;6412.39082287182;6528.575642583264;6532.3467653234775;6541.247756508015;6546.18172728409;4605.677602567788;4610.723356598614;4610.97694511532;4611.723296602215;4617.930731039037;4552.544745525421;4662;4669.042846216517;4684.789184486706;4694.2723877799;5345.732713364317;5348.465153484621;5349.545288650431;5353.250544923714;5353.866153346197;6369.649669268235;6372.865090194744;6376.011718183689;6381.074744162163;6384.201974753156;1632.755086736999;1638.8443097905679;1641.3926847066423;1641.8671116929281;1642.6468309313555;1079.9730006749737;1107.5514416661265;1111.6498303034518;1112.6495154026618;1114.2590177532013;6150.7847225346895;6151.2618485781095;6156.907646385308;6162.7226774795245;6163.3528479509905;6559.836004099936;6575.276719560845;6576.342365763481;6580.901286480706;6581.407673309425;5997;6153.1693221415435;6158.692065396713;6170.598911070766;6177.498113264135;3543.3976224041976;3567.090391950036;3568.964310356915;3569.714422846166;3574.0350105471375;6608.900866487006;6633.303503132198;6636.303188165173;6639.369259920397;6657.833554161185;6721.563098398588;6760.614074114795;6762.323767623198;6767.966160169266;6773.6613169341335;6530.575512591667;6827.556208846409;6835.726570937206;6881.827954301082;6887.827804304932;6374.107624932421;6466.159399278252;6545.116409284686;6658.1344425224415;6672;6492.577982431127;6509.381608747161;6522.510811689237;6525.021246813016;6532.510061745483;6684.966575167093;6691.899621505779;6696.19645642526;6714.194296684429;6858.142732158481;4411.713238639478;4490.77546122686;4518.390017347616;4525.909481810279;4543.454785425638;6626.900596491153;6634.369734875179;6637.568558043712;6642.6014439133805;6645.767398141042;6462.224533056064;6469.320721324381;6471.708773105316;6472.708728107153;6473.741050358121;6288.182536270256;6458.838529036811;6460.773872914613;6462.935370646422;6465.1595292611655;6291.245050593958;6303.180586523723;6313.652749098844;6323.430891219812;6331.366863313816;6494.350564943468;6503.869922601616;6505.121808555785;6505.967470162619;6508.7721929734125;6212.782552610637;6327.430531252209;6333.36666333363;6339.714712838026;6340.873182536416 10:02:18 INFO - 2015-11-19 10:02:18,580 DEBUG : BROWSER_OUTPUT: |5;yui.html;759.8290384663455;764.0716529416758;767.3554214459853;838.6393850644221;839.8212764685665;13695.109817861832;13927;13928.721425571495;13961.44154233832;13961.650958726024;12915.612531624067;12983.48066077358;14248.928755356235;14653.340599673014;14680.779788303184;807.6971135824066;817.2562967699395;819.4960099538771;822.411975437562;824.4640983360833;808.4421748993205;812.7764864662206;818.9058258300282;819.4100247821559;822.9094799572042;853.8761879527465;866.9393142480029;868.8175483148515;869.4783130121908;869.5087275689247;855.5807654249404;863.9395242333039;864.5029108262743;867.2974890338783;867.6529388244721;620.5625034350771;622.757124721359;624.3288464900205;625.2122325869392;626.9341719119518;13570.864291357058;13801.723965520634;13936.954728395309;13963.58109256724;13974.58076257714;10156.187504999582;10308.94845525775;10546.578136874516;10806.18953578477;10887.727806804814;9079.818403631956;9402.576884040234;9442.811143777086;9590.712278631652;9714.125728684452;3052.8320942348164;3056.3581647853757;3107.7979931304617;3109.875604975798;3122.625284965796;45414;46050.76974615139;46112;46124.30813537799;46293;7196.10048743907;7288.781336559911;7299.160596531361;7463.104427468738;7498.512596681198;12008.879911200951;12078.335691536875;12083.214591051554;12719.427625756864;12761;6576.145101136822;6605.339466053356;6836.4530837532875;6846.246912839583;6940.583564986117;4105.91788164235;4109.609587089221;4217.472815898012;4235.97882010588;4240.088380998101;2831.617731606248;2868.225579093633;2875.3386721053857;2875.7699384049224;2876.7267109624554;453.33359960857484;459.0612198054986;464.30818081058976;465.36477707928435;466.51249444330756;616.3189675408698;622.7602373086395;624.643952946816;659.0871642774696;669.8928171492538;8146;8259.504429734236;8265.669373225124;8340.416170868102;8442.662293508314;646.5409559212917;651.8435575461855;656.8357910522369;661.7551505942832;664.773976847874;3769;4003.6396724294955;4087.448194493705;4235.2800023996;4357.346398040319;56584.43415565792;56617.716911416006;57913.420865791646;58184.41815581875;58242.7087864558;50957.49042509602;51386;51475;52366.73816630969;52706.20940685893;40453;40746;45460.318095227936;46120;50735.74632126742;8101.594920253846;8442.957785211034;8485.95757021211;8553.187447192508;8736.519491428033;30741;36076;36441.17794110337;36923.26153476969;37154;46473.302900457194;46848.297275541576;46884.29673554831;48525;48542.757286213346;7561.319481246494;7591.734289299848;7621;7635.274648908345;7719.961400193188;10637.04334986607;10885.727856803644;10977.615783447542;11003.944980275368;11169.664910052712;10047.497625118862;10194.949025254826;10243.795124097625;10245.334053286513;10293.3823970562;10034.397936123856;10419.791604167722;10423.270371073952;10465.633702820669;10698.946505267424;10233.437160956219;10598.15214782831;10683.679489615324;10739.087177589992;11212.66362009141;9277.443353398818;9402.764930876783;9662.903370966482;9686.660966866126;9790.26573007013;8407.53758543286;8608.61261243258;8869.911300886908;9110.134537218953;9306 10:02:18 INFO - 2015-11-19 10:02:18,580 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:02:18 INFO - 2015-11-19 10:02:18,580 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:02:18 INFO - 2015-11-19 10:02:18,581 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1134 10:02:18 INFO - 2015-11-19 10:02:18,581 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:02:18 INFO - 2015-11-19 10:02:18,581 DEBUG : BROWSER_OUTPUT: __startTimestamp1447956138571__endTimestamp 10:02:18 INFO - 2015-11-19 10:02:18,581 DEBUG : BROWSER_OUTPUT: 10:02:18 INFO - 2015-11-19 10:02:18,581 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:02:18 INFO - 2015-11-19 10:02:18,581 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:02:18 INFO - 2015-11-19 10:02:18,581 DEBUG : BROWSER_OUTPUT: 10:02:18 INFO - 2015-11-19 10:02:18,581 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5547.53 Median:5736.40 stddev:631.53 (11.0%) stddev-sans-first:606.68 10:02:18 INFO - 2015-11-19 10:02:18,582 DEBUG : BROWSER_OUTPUT: Values: 3227.4 3288.9 3326.0 3334.8 3345.7 5405.3 5528.1 5564.4 5575.0 5575.4 5482.2 5575.7 5601.2 5635.1 5640.1 5048.5 5065.8 5088.8 5090.4 5117.4 4873.2 5164.3 5186.9 5196.8 5248.4 4971.2 4996.3 5051.3 5056.8 5073.3 5041.8 5044.3 5044.7 5050.2 5087.2 4940.3 5010.4 5010.9 5029.5 5070.0 5356.1 5458.0 5459.2 5486.7 5510.9 6036.9 6036.9 6037.2 6044.7 6045.7 5792.9 5937.0 5937.3 6069.2 6077.0 5581.2 5637.7 5639.5 5641.8 5700.6 6078.0 6080.4 6086.8 6088.5 6102.5 5683.1 5736.4 5796.7 5910.6 5962.7 5912.1 5967.6 6013.1 6018.5 6064.7 5909.5 5960.8 5982.6 5983.8 5989.3 5806.3 5916.3 5916.9 5963.7 5969.9 4535.2 4573.7 4577.0 4619.9 4629.4 4036.1 4038.6 4047.2 4073.8 4113.5 5459.1 5572.6 5585.9 5644.0 5651.3 5879.3 5931.6 5988.6 5991.9 6031.8 5517.6 5563.5 5593.4 5606.7 5619.5 4999.6 5121.6 5127.8 5144.0 5146.4 6099.1 6251.6 6258.1 6261.8 6264.3 6081.3 6097.0 6103.9 6104.6 6106.6 5946.8 6014.9 6085.9 6241.3 6261.9 5929.0 6011.0 6017.0 6021.2 6068.3 6016.5 6065.2 6066.7 6066.8 6071.2 5689.7 5857.0 5868.6 5929.4 5936.9 5798.0 5876.7 5878.9 5879.6 5929.5 5753.5 5802.3 5806.3 5809.2 5816.4 5575.9 5784.6 5849.4 5951.2 5962.3 5691.1 5700.7 5700.7 5719.7 5790.9 10:02:18 INFO - 2015-11-19 10:02:18,582 DEBUG : BROWSER_OUTPUT: 10:02:18 INFO - 2015-11-19 10:02:18,582 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45316.21 Median:179859.00 stddev:76006.70 (42.3%) stddev-sans-first:76145.69 10:02:18 INFO - 2015-11-19 10:02:18,583 DEBUG : BROWSER_OUTPUT: Values: 577.2 578.7 582.1 594.5 598.4 30943.4 31599.0 31602.4 31614.0 31625.1 32030.0 32660.0 39218.6 40001.6 40015.2 8656.4 8795.3 8798.1 8806.1 8810.6 7848.0 8663.6 8776.6 8777.7 8778.3 7838.5 10605.3 10856.2 10856.9 10861.7 10355.8 10390.5 10459.8 10463.7 10467.0 7857.8 8062.6 10186.2 10330.4 10497.3 39387.0 39672.4 39710.8 39731.8 39740.6 3518.6 3792.9 3819.9 3899.3 4129.6 30529.8 30983.0 31061.2 31143.7 31393.8 3251.3 3272.6 3326.9 3382.3 3448.6 276135.6 276435.0 276658.0 277161.0 277736.0 57022.0 57061.0 57167.4 57235.7 57371.0 61057.1 61347.4 61670.4 61740.7 61796.0 14986.4 15200.4 15357.5 15409.0 15416.4 11014.6 11019.5 11020.7 11026.6 11072.6 18437.0 18705.2 18706.7 18880.7 18891.1 7198.6 7381.6 7463.8 7527.9 7592.7 882.4 905.6 944.9 1003.7 1043.9 27976.0 28817.3 29148.1 29674.4 29722.9 964.8 966.5 1024.1 1032.0 1041.0 13830.0 13847.4 13973.6 14076.4 14160.7 322509.0 327058.0 327227.0 327407.0 328037.0 42035.4 42503.1 47003.5 47291.0 47482.8 1334.9 1335.8 1342.2 1364.2 1367.0 23527.0 23808.8 24552.4 24710.6 29504.3 45325.8 45522.8 45658.0 45710.3 45740.0 263669.0 265410.0 265714.0 265872.0 266820.0 29719.7 29905.3 29964.0 29969.1 30276.8 40831.4 41385.4 41443.2 42200.2 42488.0 34649.1 35240.6 35244.8 35259.5 35835.8 35197.6 35744.1 36228.5 36245.6 36246.5 34305.7 34938.0 35004.3 35009.3 35242.3 29930.3 31485.5 32104.4 32291.8 32459.8 24782.0 25233.7 25596.0 26175.9 26264.2 10:02:18 INFO - 2015-11-19 10:02:18,583 DEBUG : BROWSER_OUTPUT: 10:02:18 INFO - 2015-11-19 10:02:18,584 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29091.30 Median:473.74 stddev:98981.30 (20893.4%) stddev-sans-first:99235.44 10:02:18 INFO - 2015-11-19 10:02:18,584 DEBUG : BROWSER_OUTPUT: Values: 356.2 357.5 357.7 357.8 358.0 14260.5 14412.8 16403.6 16711.7 17414.3 15579.3 16344.3 16732.8 16758.5 17058.7 5278.0 5419.4 5423.2 5423.6 5424.3 3783.9 3882.5 5341.0 5421.3 5763.5 5791.2 5823.5 5848.2 5853.4 5854.2 5646.2 5739.1 5789.9 5798.3 5820.5 5062.8 5077.1 5085.5 5095.9 5123.9 19443.1 19457.3 19565.2 20299.3 20332.1 1984.4 2020.8 2030.7 2076.3 2148.8 12509.0 12513.3 12762.9 12778.5 12828.6 1632.3 1643.6 1680.4 1695.7 1780.8 59710.4 60319.4 60668.7 61121.7 61725.7 6751.0 6978.2 6980.5 7022.2 7042.8 8416.6 8422.0 8422.2 8424.7 8438.6 5402.0 5424.5 5470.6 5502.7 5514.4 5554.3 5603.5 5610.9 5620.5 5648.2 3208.9 3254.1 3271.2 3283.1 3292.4 1107.1 1145.4 1157.5 1171.8 1196.2 413.7 417.7 458.4 484.8 511.9 9890.9 10718.8 10784.6 10798.9 10880.8 433.0 437.0 440.1 447.7 458.1 5765.8 5984.5 5991.8 6036.3 6088.9 596629.0 598592.0 608797.0 609999.0 610362.0 58633.0 76557.6 79342.6 79901.0 80112.2 471.2 476.3 478.2 479.4 481.2 9718.5 9811.2 9854.7 9959.5 9978.6 34725.3 34885.3 35549.3 35563.1 36269.0 47054.8 47776.5 47824.5 47952.8 49413.8 6677.0 6787.7 6796.8 6797.5 6800.3 11508.9 11773.5 11973.8 12065.8 12126.4 10492.2 10677.1 10688.4 10808.3 10861.3 10436.1 10801.7 10914.4 10950.6 10991.9 10272.8 10869.8 11180.7 11254.0 11266.0 6718.1 6728.3 6741.2 6799.8 6829.6 10731.6 10797.7 10890.8 11113.4 11116.3 10:02:18 INFO - 2015-11-19 10:02:18,584 DEBUG : BROWSER_OUTPUT: 10:02:18 INFO - 2015-11-19 10:02:18,584 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5511.97 Median:6681.58 stddev:2843.72 (42.6%) stddev-sans-first:2834.17 10:02:18 INFO - 2015-11-19 10:02:18,586 DEBUG : BROWSER_OUTPUT: Values: 1311.5 1430.8 1501.1 1595.3 1718.4 6634.6 7519.7 7791.2 7796.3 7798.4 7529.8 7622.1 7622.8 7632.5 7638.0 1968.1 2029.9 2034.3 2297.7 2320.4 2311.6 2364.9 2367.1 2368.3 2368.6 2295.8 2306.0 2356.3 2356.6 2359.1 1968.4 2012.6 2293.1 2336.8 2338.8 2306.1 2309.7 2310.2 2318.1 2319.2 7807.4 7849.2 7893.6 7904.8 7911.5 4755.7 4854.6 4878.8 4889.8 4896.0 3135.2 3158.3 3191.5 3202.1 3250.1 1110.9 1788.4 1801.2 1845.2 1871.4 10525.2 10626.3 10676.1 10706.0 10718.3 4194.6 4248.3 4310.0 4313.4 4316.3 8779.4 8783.6 8797.9 8816.6 8818.7 4804.9 4806.1 4836.3 4838.4 4841.9 4453.6 4455.2 4456.2 4456.5 4458.7 3469.4 3516.7 3525.2 3548.9 3553.6 1091.7 1109.2 1116.5 1133.2 1133.3 1009.7 1016.0 1037.9 1038.3 1170.9 6361.4 7585.1 7688.1 7693.5 7694.3 704.0 704.7 735.8 736.0 738.8 5769.3 5781.0 5840.4 5845.1 5867.6 9513.6 9594.0 9678.5 9694.5 9703.8 9282.3 9520.4 9542.4 9568.2 9580.1 7266.6 7313.0 7315.2 7320.8 7323.4 7025.2 7109.1 7120.0 7143.5 7425.4 8182.8 8445.4 8465.0 8484.9 8510.3 8428.0 8475.0 8592.7 8666.4 8711.5 7129.5 7186.6 7192.4 7199.5 7202.1 7632.4 7702.5 7734.7 7743.3 7752.3 7096.8 7146.1 7183.9 7278.7 7369.3 7093.4 7108.6 7132.9 7236.6 7307.5 7253.5 7293.1 7297.2 7301.9 7307.2 5523.9 6157.7 6632.9 6672.4 6690.8 6692.9 6697.8 6721.7 6734.5 6736.4 10:02:18 INFO - 2015-11-19 10:02:18,586 DEBUG : BROWSER_OUTPUT: 10:02:18 INFO - 2015-11-19 10:02:18,586 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5339.64 Median:6059.51 stddev:1595.59 (26.3%) stddev-sans-first:1555.24 10:02:18 INFO - 2015-11-19 10:02:18,586 DEBUG : BROWSER_OUTPUT: Values: 336.1 336.6 338.4 345.9 347.1 5836.0 5958.9 5997.6 6010.9 6048.9 5812.4 5940.3 5953.6 5958.1 5960.2 4590.3 4621.2 4636.0 4636.7 4663.3 4452.2 4536.8 4540.5 4647.9 4660.0 4561.2 4566.7 4584.5 4598.1 4612.7 4575.4 4580.4 4591.2 4609.5 4621.8 4058.7 4062.3 4062.4 4067.4 4067.8 5581.4 5632.0 5651.9 5664.5 5670.1 5361.7 5368.3 5373.9 5375.6 5378.4 6070.1 6328.6 6332.5 6334.7 6337.6 4352.1 4417.5 4487.5 4491.2 4496.3 6412.4 6528.6 6532.3 6541.2 6546.2 4605.7 4610.7 4611.0 4611.7 4617.9 4552.5 4662.0 4669.0 4684.8 4694.3 5345.7 5348.5 5349.5 5353.3 5353.9 6369.6 6372.9 6376.0 6381.1 6384.2 1632.8 1638.8 1641.4 1641.9 1642.6 1080.0 1107.6 1111.6 1112.6 1114.3 6150.8 6151.3 6156.9 6162.7 6163.4 6559.8 6575.3 6576.3 6580.9 6581.4 5997.0 6153.2 6158.7 6170.6 6177.5 3543.4 3567.1 3569.0 3569.7 3574.0 6608.9 6633.3 6636.3 6639.4 6657.8 6721.6 6760.6 6762.3 6768.0 6773.7 6530.6 6827.6 6835.7 6881.8 6887.8 6374.1 6466.2 6545.1 6658.1 6672.0 6492.6 6509.4 6522.5 6525.0 6532.5 6685.0 6691.9 6696.2 6714.2 6858.1 4411.7 4490.8 4518.4 4525.9 4543.5 6626.9 6634.4 6637.6 6642.6 6645.8 6462.2 6469.3 6471.7 6472.7 6473.7 6288.2 6458.8 6460.8 6462.9 6465.2 6291.2 6303.2 6313.7 6323.4 6331.4 6494.4 6503.9 6505.1 6506.0 6508.8 6212.8 6327.4 6333.4 6339.7 6340.9 10:02:18 INFO - 2015-11-19 10:02:18,587 DEBUG : BROWSER_OUTPUT: 10:02:18 INFO - 2015-11-19 10:02:18,587 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13244.22 Median:51171.75 stddev:16050.69 (31.4%) stddev-sans-first:16068.34 10:02:18 INFO - 2015-11-19 10:02:18,587 DEBUG : BROWSER_OUTPUT: Values: 759.8 764.1 767.4 838.6 839.8 13695.1 13927.0 13928.7 13961.4 13961.7 12915.6 12983.5 14248.9 14653.3 14680.8 807.7 817.3 819.5 822.4 824.5 808.4 812.8 818.9 819.4 822.9 853.9 866.9 868.8 869.5 869.5 855.6 863.9 864.5 867.3 867.7 620.6 622.8 624.3 625.2 626.9 13570.9 13801.7 13937.0 13963.6 13974.6 10156.2 10308.9 10546.6 10806.2 10887.7 9079.8 9402.6 9442.8 9590.7 9714.1 3052.8 3056.4 3107.8 3109.9 3122.6 45414.0 46050.8 46112.0 46124.3 46293.0 7196.1 7288.8 7299.2 7463.1 7498.5 12008.9 12078.3 12083.2 12719.4 12761.0 6576.1 6605.3 6836.5 6846.2 6940.6 4105.9 4109.6 4217.5 4236.0 4240.1 2831.6 2868.2 2875.3 2875.8 2876.7 453.3 459.1 464.3 465.4 466.5 616.3 622.8 624.6 659.1 669.9 8146.0 8259.5 8265.7 8340.4 8442.7 646.5 651.8 656.8 661.8 664.8 3769.0 4003.6 4087.4 4235.3 4357.3 56584.4 56617.7 57913.4 58184.4 58242.7 50957.5 51386.0 51475.0 52366.7 52706.2 40453.0 40746.0 45460.3 46120.0 50735.7 8101.6 8443.0 8486.0 8553.2 8736.5 30741.0 36076.0 36441.2 36923.3 37154.0 46473.3 46848.3 46884.3 48525.0 48542.8 7561.3 7591.7 7621.0 7635.3 7720.0 10637.0 10885.7 10977.6 11003.9 11169.7 10047.5 10194.9 10243.8 10245.3 10293.4 10034.4 10419.8 10423.3 10465.6 10698.9 10233.4 10598.2 10683.7 10739.1 11212.7 9277.4 9402.8 9662.9 9686.7 9790.3 8407.5 8608.6 8869.9 9110.1 9306.0 10:02:18 INFO - 2015-11-19 10:02:18,587 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:02:18 INFO - 2015-11-19 10:02:18,587 DEBUG : BROWSER_OUTPUT: 10:02:19 INFO - 2015-11-19 10:02:19,253 INFO : Browser exited with error code: 0 10:02:19 INFO - 2015-11-19 10:02:19,272 INFO : Completed test dromaeo_css (00:18:33) 10:02:19 INFO - 2015-11-19 10:02:19,272 INFO : Starting test kraken 10:02:19 INFO - 2015-11-19 10:02:19,272 DEBUG : operating with platform_type : linux_ 10:02:19 INFO - 2015-11-19 10:02:19,272 INFO : Initialising browser for kraken test... 10:02:19 INFO - 2015-11-19 10:02:19,278 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1z8qWk/profile http://localhost:37630/getInfo.html 10:02:22 INFO - 2015-11-19 10:02:22,999 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:02:23 INFO - 2015-11-19 10:02:22,999 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:02:23 INFO - 2015-11-19 10:02:22,999 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:02:23 INFO - 2015-11-19 10:02:22,999 DEBUG : BROWSER_OUTPUT: __metrics 10:02:23 INFO - 2015-11-19 10:02:23,076 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:02:24 INFO - 2015-11-19 10:02:24,397 INFO : Browser initialized. 10:02:24 INFO - 2015-11-19 10:02:24,398 INFO : Running cycle 1/1 for kraken test... 10:02:24 INFO - 2015-11-19 10:02:24,398 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1z8qWk/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:02:36 INFO - 2015-11-19 10:02:36,163 DEBUG : BROWSER_OUTPUT: RSS: Main: 141864960 10:02:36 INFO - 2015-11-19 10:02:36,164 DEBUG : BROWSER_OUTPUT: 10:02:38 INFO - 2015-11-19 10:02:38,618 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37630/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37630/tests/kraken/driver.html?testName=audio-beat-detection) 10:02:39 INFO - 2015-11-19 10:02:39,204 DEBUG : BROWSER_OUTPUT: RSS: Main: 179724288 10:02:39 INFO - 2015-11-19 10:02:39,204 DEBUG : BROWSER_OUTPUT: 10:02:41 INFO - 2015-11-19 10:02:41,801 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37630/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37630/tests/kraken/driver.html?testName=audio-dft) 10:02:42 INFO - 2015-11-19 10:02:42,370 DEBUG : BROWSER_OUTPUT: RSS: Main: 167727104 10:02:42 INFO - 2015-11-19 10:02:42,370 DEBUG : BROWSER_OUTPUT: 10:02:45 INFO - 2015-11-19 10:02:45,214 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37630/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37630/tests/kraken/driver.html?testName=audio-fft) 10:02:45 INFO - 2015-11-19 10:02:45,767 DEBUG : BROWSER_OUTPUT: RSS: Main: 151855104 10:02:45 INFO - 2015-11-19 10:02:45,767 DEBUG : BROWSER_OUTPUT: 10:02:47 INFO - 2015-11-19 10:02:47,751 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37630/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37630/tests/kraken/driver.html?testName=audio-oscillator) 10:02:48 INFO - 2015-11-19 10:02:48,324 DEBUG : BROWSER_OUTPUT: RSS: Main: 153673728 10:02:48 INFO - 2015-11-19 10:02:48,325 DEBUG : BROWSER_OUTPUT: 10:02:50 INFO - 2015-11-19 10:02:50,497 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37630/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37630/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:02:51 INFO - 2015-11-19 10:02:51,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 155123712 10:02:51 INFO - 2015-11-19 10:02:51,063 DEBUG : BROWSER_OUTPUT: 10:02:53 INFO - 2015-11-19 10:02:53,948 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37630/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37630/tests/kraken/driver.html?testName=imaging-darkroom) 10:02:54 INFO - 2015-11-19 10:02:54,518 DEBUG : BROWSER_OUTPUT: RSS: Main: 156028928 10:02:54 INFO - 2015-11-19 10:02:54,518 DEBUG : BROWSER_OUTPUT: 10:02:57 INFO - 2015-11-19 10:02:57,919 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37630/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37630/tests/kraken/driver.html?testName=imaging-desaturate) 10:02:58 INFO - 2015-11-19 10:02:58,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 156225536 10:02:58 INFO - 2015-11-19 10:02:58,493 DEBUG : BROWSER_OUTPUT: 10:03:01 INFO - 2015-11-19 10:03:01,264 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37630/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37630/tests/kraken/driver.html?testName=json-parse-financial) 10:03:01 INFO - 2015-11-19 10:03:01,839 DEBUG : BROWSER_OUTPUT: RSS: Main: 155852800 10:03:01 INFO - 2015-11-19 10:03:01,840 DEBUG : BROWSER_OUTPUT: 10:03:03 INFO - 2015-11-19 10:03:03,355 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37630/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37630/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:03:03 INFO - 2015-11-19 10:03:03,928 DEBUG : BROWSER_OUTPUT: RSS: Main: 166248448 10:03:03 INFO - 2015-11-19 10:03:03,929 DEBUG : BROWSER_OUTPUT: 10:03:05 INFO - 2015-11-19 10:03:05,726 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37630/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37630/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:03:06 INFO - 2015-11-19 10:03:06,328 DEBUG : BROWSER_OUTPUT: RSS: Main: 163794944 10:03:06 INFO - 2015-11-19 10:03:06,328 DEBUG : BROWSER_OUTPUT: 10:03:08 INFO - 2015-11-19 10:03:08,387 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37630/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37630/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:03:08 INFO - 2015-11-19 10:03:08,960 DEBUG : BROWSER_OUTPUT: RSS: Main: 172793856 10:03:08 INFO - 2015-11-19 10:03:08,960 DEBUG : BROWSER_OUTPUT: 10:03:11 INFO - 2015-11-19 10:03:11,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37630/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37630/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:03:11 INFO - 2015-11-19 10:03:11,941 DEBUG : BROWSER_OUTPUT: RSS: Main: 181264384 10:03:11 INFO - 2015-11-19 10:03:11,941 DEBUG : BROWSER_OUTPUT: 10:03:14 INFO - 2015-11-19 10:03:14,528 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37630/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37630/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:03:15 INFO - 2015-11-19 10:03:15,096 DEBUG : BROWSER_OUTPUT: RSS: Main: 178417664 10:03:15 INFO - 2015-11-19 10:03:15,096 DEBUG : BROWSER_OUTPUT: 10:03:16 INFO - 2015-11-19 10:03:16,783 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37630/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37630/tests/kraken/driver.html?testName=ai-astar) 10:03:17 INFO - 2015-11-19 10:03:17,030 DEBUG : BROWSER_OUTPUT: RSS: Main: 237527040 10:03:17 INFO - 2015-11-19 10:03:17,030 DEBUG : BROWSER_OUTPUT: 10:03:17 INFO - 2015-11-19 10:03:17,031 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:03:17 INFO - 2015-11-19 10:03:17,031 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:03:17 INFO - 2015-11-19 10:03:17,032 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:03:17 INFO - 2015-11-19 10:03:17,032 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:03:17 INFO - 2015-11-19 10:03:17,032 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;111;104;109;110;111;99;111;110;109 10:03:17 INFO - 2015-11-19 10:03:17,032 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;124;149;166;129;155;149;130;166;123 10:03:17 INFO - 2015-11-19 10:03:17,032 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;163;161;160;160;160;163;162;162 10:03:17 INFO - 2015-11-19 10:03:17,032 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;80;95;72;72;73;108;88;71 10:03:17 INFO - 2015-11-19 10:03:17,032 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;90;142;90;90;91;143;89;91;134 10:03:17 INFO - 2015-11-19 10:03:17,032 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;110;110;109;109;109;109;109 10:03:17 INFO - 2015-11-19 10:03:17,033 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;145;146;146;145;146;145;146;146 10:03:17 INFO - 2015-11-19 10:03:17,033 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;95;96;97;95;96;95;96 10:03:17 INFO - 2015-11-19 10:03:17,033 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;56;58;56;56;56;60;64;54;55 10:03:17 INFO - 2015-11-19 10:03:17,033 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;68;70;69;69;69;68;69 10:03:17 INFO - 2015-11-19 10:03:17,033 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;84;85;85;84;86;85;93;85;87 10:03:17 INFO - 2015-11-19 10:03:17,033 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;119;126;117;122;120;117;115;118;124 10:03:17 INFO - 2015-11-19 10:03:17,033 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;153;155;152;152;142;151;151;152;141 10:03:17 INFO - 2015-11-19 10:03:17,034 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;68;67;68;68;73;68;68;69;68 10:03:17 INFO - 2015-11-19 10:03:17,034 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:03:17 INFO - 2015-11-19 10:03:17,034 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:03:17 INFO - 2015-11-19 10:03:17,034 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,938 10:03:17 INFO - 2015-11-19 10:03:17,034 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:03:17 INFO - 2015-11-19 10:03:17,034 DEBUG : BROWSER_OUTPUT: __startTimestamp1447956197030__endTimestamp 10:03:17 INFO - 2015-11-19 10:03:17,034 DEBUG : BROWSER_OUTPUT: 10:03:17 INFO - 2015-11-19 10:03:17,038 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:03:17 INFO - 2015-11-19 10:03:17,038 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:03:17 INFO - 2015-11-19 10:03:17,038 DEBUG : BROWSER_OUTPUT: 10:03:17 INFO - 2015-11-19 10:03:17,039 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.30 Median:110.50 stddev:3.86 (3.5%) stddev-sans-first:4.09 10:03:17 INFO - 2015-11-19 10:03:17,039 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 104.0 109.0 110.0 111.0 99.0 111.0 110.0 109.0 10:03:17 INFO - 2015-11-19 10:03:17,039 DEBUG : BROWSER_OUTPUT: 10:03:17 INFO - 2015-11-19 10:03:17,039 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.40 Median:151.00 stddev:16.60 (11.0%) stddev-sans-first:17.31 10:03:17 INFO - 2015-11-19 10:03:17,039 DEBUG : BROWSER_OUTPUT: Values: 153.0 124.0 149.0 166.0 129.0 155.0 149.0 130.0 166.0 123.0 10:03:17 INFO - 2015-11-19 10:03:17,039 DEBUG : BROWSER_OUTPUT: 10:03:17 INFO - 2015-11-19 10:03:17,040 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.17 (0.7%) stddev-sans-first:1.24 10:03:17 INFO - 2015-11-19 10:03:17,040 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 163.0 161.0 160.0 160.0 160.0 163.0 162.0 162.0 10:03:17 INFO - 2015-11-19 10:03:17,040 DEBUG : BROWSER_OUTPUT: 10:03:17 INFO - 2015-11-19 10:03:17,040 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.20 Median:72.50 stddev:12.80 (17.7%) stddev-sans-first:13.23 10:03:17 INFO - 2015-11-19 10:03:17,040 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 80.0 95.0 72.0 72.0 73.0 108.0 88.0 71.0 10:03:17 INFO - 2015-11-19 10:03:17,040 DEBUG : BROWSER_OUTPUT: 10:03:17 INFO - 2015-11-19 10:03:17,041 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.00 Median:90.00 stddev:24.04 (26.7%) stddev-sans-first:24.88 10:03:17 INFO - 2015-11-19 10:03:17,042 DEBUG : BROWSER_OUTPUT: Values: 90.0 90.0 142.0 90.0 90.0 91.0 143.0 89.0 91.0 134.0 10:03:17 INFO - 2015-11-19 10:03:17,042 DEBUG : BROWSER_OUTPUT: 10:03:17 INFO - 2015-11-19 10:03:17,042 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:03:17 INFO - 2015-11-19 10:03:17,042 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 110.0 110.0 109.0 109.0 109.0 109.0 109.0 10:03:17 INFO - 2015-11-19 10:03:17,042 DEBUG : BROWSER_OUTPUT: 10:03:17 INFO - 2015-11-19 10:03:17,042 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 10:03:17 INFO - 2015-11-19 10:03:17,042 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 145.0 146.0 146.0 145.0 146.0 145.0 146.0 146.0 10:03:17 INFO - 2015-11-19 10:03:17,042 DEBUG : BROWSER_OUTPUT: 10:03:17 INFO - 2015-11-19 10:03:17,042 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 10:03:17 INFO - 2015-11-19 10:03:17,042 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 95.0 96.0 97.0 95.0 96.0 95.0 96.0 10:03:17 INFO - 2015-11-19 10:03:17,042 DEBUG : BROWSER_OUTPUT: 10:03:17 INFO - 2015-11-19 10:03:17,043 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.10 Median:56.00 stddev:2.92 (5.2%) stddev-sans-first:3.07 10:03:17 INFO - 2015-11-19 10:03:17,043 DEBUG : BROWSER_OUTPUT: Values: 56.0 56.0 58.0 56.0 56.0 56.0 60.0 64.0 54.0 55.0 10:03:17 INFO - 2015-11-19 10:03:17,043 DEBUG : BROWSER_OUTPUT: 10:03:17 INFO - 2015-11-19 10:03:17,043 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 10:03:17 INFO - 2015-11-19 10:03:17,043 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 68.0 70.0 69.0 69.0 69.0 68.0 69.0 10:03:17 INFO - 2015-11-19 10:03:17,043 DEBUG : BROWSER_OUTPUT: 10:03:17 INFO - 2015-11-19 10:03:17,043 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.00 stddev:2.79 (3.3%) stddev-sans-first:2.78 10:03:17 INFO - 2015-11-19 10:03:17,043 DEBUG : BROWSER_OUTPUT: Values: 83.0 84.0 85.0 85.0 84.0 86.0 85.0 93.0 85.0 87.0 10:03:17 INFO - 2015-11-19 10:03:17,043 DEBUG : BROWSER_OUTPUT: 10:03:17 INFO - 2015-11-19 10:03:17,043 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.20 Median:121.00 stddev:3.65 (3.0%) stddev-sans-first:3.60 10:03:17 INFO - 2015-11-19 10:03:17,043 DEBUG : BROWSER_OUTPUT: Values: 124.0 119.0 126.0 117.0 122.0 120.0 117.0 115.0 118.0 124.0 10:03:17 INFO - 2015-11-19 10:03:17,043 DEBUG : BROWSER_OUTPUT: 10:03:17 INFO - 2015-11-19 10:03:17,043 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.50 Median:152.00 stddev:4.79 (3.2%) stddev-sans-first:4.91 10:03:17 INFO - 2015-11-19 10:03:17,043 DEBUG : BROWSER_OUTPUT: Values: 146.0 153.0 155.0 152.0 152.0 142.0 151.0 151.0 152.0 141.0 10:03:17 INFO - 2015-11-19 10:03:17,043 DEBUG : BROWSER_OUTPUT: 10:03:17 INFO - 2015-11-19 10:03:17,043 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:68.00 stddev:1.70 (2.5%) stddev-sans-first:1.74 10:03:17 INFO - 2015-11-19 10:03:17,044 DEBUG : BROWSER_OUTPUT: Values: 70.0 68.0 67.0 68.0 68.0 73.0 68.0 68.0 69.0 68.0 10:03:17 INFO - 2015-11-19 10:03:17,044 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:03:17 INFO - 2015-11-19 10:03:17,044 DEBUG : BROWSER_OUTPUT: 10:03:17 INFO - 2015-11-19 10:03:17,961 INFO : Browser exited with error code: 0 10:03:18 INFO - 2015-11-19 10:03:18,016 INFO : Completed test kraken (00:00:58) 10:03:18 INFO - 2015-11-19 10:03:18,016 INFO : Starting test v8_7 10:03:18 INFO - 2015-11-19 10:03:18,016 DEBUG : operating with platform_type : linux_ 10:03:18 INFO - 2015-11-19 10:03:18,016 INFO : Initialising browser for v8_7 test... 10:03:18 INFO - 2015-11-19 10:03:18,022 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpk4JMS7/profile http://localhost:37630/getInfo.html 10:03:21 INFO - 2015-11-19 10:03:21,826 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:03:21 INFO - 2015-11-19 10:03:21,826 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:03:21 INFO - 2015-11-19 10:03:21,826 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:03:21 INFO - 2015-11-19 10:03:21,826 DEBUG : BROWSER_OUTPUT: __metrics 10:03:21 INFO - 2015-11-19 10:03:21,984 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:03:23 INFO - 2015-11-19 10:03:23,141 INFO : Browser initialized. 10:03:23 INFO - 2015-11-19 10:03:23,142 INFO : Running cycle 1/1 for v8_7 test... 10:03:23 INFO - 2015-11-19 10:03:23,142 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpk4JMS7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:03:34 INFO - 2015-11-19 10:03:34,855 DEBUG : BROWSER_OUTPUT: RSS: Main: 141914112 10:03:34 INFO - 2015-11-19 10:03:34,856 DEBUG : BROWSER_OUTPUT: 10:03:56 INFO - 2015-11-19 10:03:56,290 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37630/tests/v8_7/run.html (next: http://localhost:37630/tests/v8_7/run.html) 10:03:56 INFO - 2015-11-19 10:03:56,540 DEBUG : BROWSER_OUTPUT: RSS: Main: 177319936 10:03:56 INFO - 2015-11-19 10:03:56,541 DEBUG : BROWSER_OUTPUT: 10:03:56 INFO - 2015-11-19 10:03:56,542 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:03:56 INFO - 2015-11-19 10:03:56,542 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:03:56 INFO - 2015-11-19 10:03:56,542 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:03:56 INFO - 2015-11-19 10:03:56,542 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:03:56 INFO - 2015-11-19 10:03:56,543 DEBUG : BROWSER_OUTPUT: |0;Richards;163.18537859007833 10:03:56 INFO - 2015-11-19 10:03:56,543 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.47685725398676 10:03:56 INFO - 2015-11-19 10:03:56,543 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.7959416976279 10:03:56 INFO - 2015-11-19 10:03:56,543 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 10:03:56 INFO - 2015-11-19 10:03:56,543 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1104.9723756906078 10:03:56 INFO - 2015-11-19 10:03:56,544 DEBUG : BROWSER_OUTPUT: |5;Earley;779.423226812159 10:03:56 INFO - 2015-11-19 10:03:56,544 DEBUG : BROWSER_OUTPUT: |6;Boyer;12156.626506024097 10:03:56 INFO - 2015-11-19 10:03:56,544 DEBUG : BROWSER_OUTPUT: |7;RegExp;26500 10:03:56 INFO - 2015-11-19 10:03:56,544 DEBUG : BROWSER_OUTPUT: |8;Splay;578.368999421631 10:03:56 INFO - 2015-11-19 10:03:56,544 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 10:03:56 INFO - 2015-11-19 10:03:56,544 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:03:56 INFO - 2015-11-19 10:03:56,544 DEBUG : BROWSER_OUTPUT: __startTimestamp1447956236541__endTimestamp 10:03:56 INFO - 2015-11-19 10:03:56,545 DEBUG : BROWSER_OUTPUT: 10:03:56 INFO - 2015-11-19 10:03:56,545 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:03:56 INFO - 2015-11-19 10:03:56,545 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:03:56 INFO - 2015-11-19 10:03:56,545 DEBUG : BROWSER_OUTPUT: 10:03:56 INFO - 2015-11-19 10:03:56,545 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.19 Median:163.19 stddev:0.00 (0.0%) 10:03:56 INFO - 2015-11-19 10:03:56,545 DEBUG : BROWSER_OUTPUT: Values: 163.2 10:03:56 INFO - 2015-11-19 10:03:56,545 DEBUG : BROWSER_OUTPUT: 10:03:56 INFO - 2015-11-19 10:03:56,545 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.48 Median:194.48 stddev:0.00 (0.0%) 10:03:56 INFO - 2015-11-19 10:03:56,545 DEBUG : BROWSER_OUTPUT: Values: 194.5 10:03:56 INFO - 2015-11-19 10:03:56,546 DEBUG : BROWSER_OUTPUT: 10:03:56 INFO - 2015-11-19 10:03:56,546 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.80 Median:285.80 stddev:0.00 (0.0%) 10:03:56 INFO - 2015-11-19 10:03:56,546 DEBUG : BROWSER_OUTPUT: Values: 285.8 10:03:56 INFO - 2015-11-19 10:03:56,546 DEBUG : BROWSER_OUTPUT: 10:03:56 INFO - 2015-11-19 10:03:56,546 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 10:03:56 INFO - 2015-11-19 10:03:56,546 DEBUG : BROWSER_OUTPUT: Values: 5040.2 10:03:56 INFO - 2015-11-19 10:03:56,546 DEBUG : BROWSER_OUTPUT: 10:03:56 INFO - 2015-11-19 10:03:56,546 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1104.97 Median:1104.97 stddev:0.00 (0.0%) 10:03:56 INFO - 2015-11-19 10:03:56,547 DEBUG : BROWSER_OUTPUT: Values: 1105.0 10:03:56 INFO - 2015-11-19 10:03:56,547 DEBUG : BROWSER_OUTPUT: 10:03:56 INFO - 2015-11-19 10:03:56,547 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:779.42 Median:779.42 stddev:0.00 (0.0%) 10:03:56 INFO - 2015-11-19 10:03:56,547 DEBUG : BROWSER_OUTPUT: Values: 779.4 10:03:56 INFO - 2015-11-19 10:03:56,547 DEBUG : BROWSER_OUTPUT: 10:03:56 INFO - 2015-11-19 10:03:56,547 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12156.63 Median:12156.63 stddev:0.00 (0.0%) 10:03:56 INFO - 2015-11-19 10:03:56,547 DEBUG : BROWSER_OUTPUT: Values: 12156.6 10:03:56 INFO - 2015-11-19 10:03:56,547 DEBUG : BROWSER_OUTPUT: 10:03:56 INFO - 2015-11-19 10:03:56,547 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26500.00 Median:26500.00 stddev:0.00 (0.0%) 10:03:56 INFO - 2015-11-19 10:03:56,548 DEBUG : BROWSER_OUTPUT: Values: 26500.0 10:03:56 INFO - 2015-11-19 10:03:56,548 DEBUG : BROWSER_OUTPUT: 10:03:56 INFO - 2015-11-19 10:03:56,548 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:578.37 Median:578.37 stddev:0.00 (0.0%) 10:03:56 INFO - 2015-11-19 10:03:56,548 DEBUG : BROWSER_OUTPUT: Values: 578.4 10:03:56 INFO - 2015-11-19 10:03:56,548 DEBUG : BROWSER_OUTPUT: 10:03:56 INFO - 2015-11-19 10:03:56,548 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 10:03:56 INFO - 2015-11-19 10:03:56,548 DEBUG : BROWSER_OUTPUT: Values: 4840.6 10:03:56 INFO - 2015-11-19 10:03:56,548 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:03:56 INFO - 2015-11-19 10:03:56,548 DEBUG : BROWSER_OUTPUT: 10:03:57 INFO - 2015-11-19 10:03:57,401 INFO : Browser exited with error code: 0 10:03:57 INFO - 2015-11-19 10:03:57,420 INFO : Completed test v8_7 (00:00:39) 10:03:57 INFO - 2015-11-19 10:03:57,505 INFO : Completed test suite (00:20:12) 10:03:57 INFO - 2015-11-19 10:03:57,505 DEBUG : Working with test: dromaeo_css 10:03:57 INFO - 2015-11-19 10:03:57,505 DEBUG : Generating results file: dromaeo_css 10:03:57 INFO - 2015-11-19 10:03:57,506 DEBUG : Working with test: kraken 10:03:57 INFO - 2015-11-19 10:03:57,506 DEBUG : Generating results file: kraken 10:03:57 INFO - 2015-11-19 10:03:57,506 INFO : javascript benchmark 10:03:57 INFO - 2015-11-19 10:03:57,507 DEBUG : Working with test: v8_7 10:03:57 INFO - 2015-11-19 10:03:57,507 DEBUG : Generating results file: v8_7 10:03:57 INFO - 2015-11-19 10:03:57,507 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:03:57 INFO - 2015-11-19 10:03:57,562 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 10:03:57 INFO - 2015-11-19 10:03:57,562 DEBUG : process_Request line: dromaeo_css 6718.04 graph.html#tests=[[72,64,35]] 10:03:57 INFO - 2015-11-19 10:03:57,563 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:03:57 INFO - 2015-11-19 10:03:57,592 DEBUG : process_Request line: kraken 1499.90 graph.html#tests=[[232,64,35]] 10:03:57 INFO - 2015-11-19 10:03:57,592 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:03:57 INFO - 2015-11-19 10:03:57,620 DEBUG : process_Request line: v8_7 21107.05 graph.html#tests=[[230,64,35]] 10:03:57 INFO - 2015-11-19 10:03:57,622 INFO : javascript benchmark 10:03:57 INFO - 2015-11-19 10:03:57,625 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3227.4190645683775, 3288.8848890288814, 3326.018824446788, 3334.7665663403573, 3345.6988871001604, 5405.297311349529, 5528.143137813645, 5564.360098588659, 5574.968630803299, 5575.386707462176, 5482.150266708657, 5575.665460072389, 5601.187827764982, 5635.070213414781, 5640.0693885508845, 5048.495150484959, 5065.797368105272, 5088.84733457995, 5090.440051594322, 5117.385913690362, 4873.1715608346485, 5164.328637277149, 5186.948130518703, 5196.792128314863, 5248.370195576517, 4971.204607262821, 4996.25056241563, 5051.267566202917, 5056.797728090872, 5073.289739436482, 5041.823536176216, 5044.2937988681615, 5044.722540260284, 5050.242463630485, 5087.211482220262, 4940.308356830046, 5010.3737032870895, 5010.949890501085, 5029.547340739351, 5070.0, 5356.11624082026, 5457.972710136463, 5459.153831156177, 5486.725663716798, 5510.862228444281, 6036.879262414727, 6036.909446358308, 6037.154798328237, 6044.667543285118, 6045.727942242565, 5792.913106303409, 5937.0, 5937.317208521033, 6069.180660610805, 6077.0, 5581.190727344553, 5637.68992705397, 5639.492445679826, 5641.830745077655, 5700.629459085146, 6078.0, 6080.361562036011, 6086.756529738761, 6088.512918966472, 6102.549845102896, 5683.062294721325, 5736.397678243808, 5796.710164491758, 5910.631648836556, 5962.731677074542, 5912.083627037816, 5967.641941483438, 6013.128096425994, 6018.488428483628, 6064.727087281083, 5909.468147866713, 5960.761569537257, 5982.551308651869, 5983.820485385445, 5989.2812862456785, 5806.332271788799, 5916.349201587822, 5916.911246331309, 5963.701814909237, 5969.910451343233, 4535.183666939916, 4573.725576465423, 4577.0, 4619.9076018479445, 4629.421322334708, 4036.1322315702264, 4038.5961403859965, 4047.170330082385, 4073.7759423232005, 4113.547509773923, 5459.099248624012, 5572.637778544382, 5585.944140558542, 5644.040513112781, 5651.265335506358, 5879.294484661782, 5931.555133365015, 5988.550858685616, 5991.910121348184, 6031.758729650853, 5517.613767036269, 5563.499285064283, 5593.412691667398, 5606.663600183921, 5619.466150715675, 4999.575036121898, 5121.564667003272, 5127.769250383742, 5144.0, 5146.356705411824, 6099.050001489054, 6251.562390632612, 6258.123862659231, 6261.843453913598, 6264.342244064399, 6081.331053584014, 6097.0, 6103.938960610337, 6104.633721976696, 6106.6336019838955, 5946.791862284799, 6014.909776353271, 6085.939140608537, 6241.282252541016, 6261.937380626136, 5929.0, 6010.9699451502465, 6017.037274036134, 6021.217241758543, 6068.302145253176, 6016.488598469179, 6065.211522502046, 6066.696665166813, 6066.848328791815, 6071.241094863142, 5689.715514224355, 5856.970715146397, 5868.559858010752, 5929.436703513159, 5936.851578710567, 5798.0, 5876.676782776988, 5878.911816322673, 5879.647221166743, 5929.495992840657, 5753.482186603226, 5802.303723553201, 5806.332271788799, 5809.157672137601, 5816.36020037804, 5575.944240557543, 5784.595078344475, 5849.415058494116, 5951.16683664296, 5962.25471816023, 5691.060974939089, 5700.657960522382, 5700.657960522382, 5719.685417301922, 5790.94209057904], "unit": "ms", "name": "dojo.html", "value": 5505.534174739792}, {"lowerIsBetter": false, "replicates": [577.1717585265145, 578.7164289498146, 582.0570675505681, 594.5451729426989, 598.4225222660132, 30943.38113237734, 31599.0, 31602.36795264096, 31614.0, 31625.051248462554, 32030.0, 32660.0, 39218.60781392185, 40001.59998400015, 40015.19969600614, 8656.394052416317, 8795.296376289882, 8798.120187981214, 8806.075362086985, 8810.603522841488, 7848.0, 8663.610137543794, 8776.56117194141, 8777.692780752675, 8778.341624378165, 7838.529688218697, 10605.310654807452, 10856.240063195579, 10856.945715271451, 10861.728456788604, 10355.844662330072, 10390.480475976246, 10459.790804183875, 10463.686089417291, 10466.953304669549, 7857.8035549111155, 8062.637181326854, 10186.185105191567, 10330.380177189318, 10497.317674351143, 39387.0, 39672.404913926315, 39710.80144599258, 39731.8013409934, 39740.60259397427, 3518.6305437928904, 3792.924141517182, 3819.866304679323, 3899.298126337258, 4129.648979836717, 30529.847350763324, 30983.0, 31061.22346941322, 31143.688563114305, 31393.843030784927, 3251.2735975531104, 3272.6236482804543, 3326.850291736878, 3382.2897191589796, 3448.620651728308, 276135.6193219041, 276435.0, 276658.0, 277161.0, 277736.0, 57022.0, 57061.0, 57167.42832571704, 57235.713821430625, 57371.0, 61057.08414373788, 61347.38652613506, 61670.38329616736, 61740.69129654413, 61796.0, 14986.40054397812, 15200.391984320724, 15357.462488812838, 15409.0, 15416.383344666088, 11014.559417623366, 11019.504122314514, 11020.724481888017, 11026.558937642405, 11072.612458563912, 18437.0, 18705.158267877978, 18706.71939920902, 18880.716789247897, 18891.14989825461, 7198.604076775828, 7381.630918454056, 7463.776086717407, 7527.9247207528315, 7592.658330375147, 882.3646974178581, 905.5924833824805, 944.9102335278137, 1003.6838395905266, 1043.909114974853, 27976.0, 28817.279568010967, 29148.10065315754, 29674.40651186964, 29722.851385743365, 964.8121494863296, 966.4877614863992, 1024.1294899335505, 1031.9948400257952, 1040.9902394677151, 13830.0, 13847.376868040761, 13973.580792576238, 14076.366563504667, 14160.716785664228, 322509.0, 327058.0, 327227.0, 327407.0, 328037.0, 42035.36946945798, 42503.149937001086, 47003.529964700596, 47291.0, 47482.76258618685, 1334.9332533373292, 1335.8063080853221, 1342.214804339453, 1364.249662685519, 1366.961109556724, 23527.0, 23808.761912380654, 24552.386190345384, 24710.629340560266, 29504.26823508362, 45325.773371132935, 45522.772386137854, 45658.0, 45710.31434528418, 45740.0, 263669.0, 265410.0, 265714.0, 265872.0, 266820.0, 29719.702802971693, 29905.252368690955, 29964.0, 29969.100926972227, 30276.84861575678, 40831.38752918768, 41385.37921931113, 41443.17113657649, 42200.15599687928, 42488.0, 34649.133771655914, 35240.64759352374, 35244.823775880956, 35259.47110793392, 35835.82082089573, 35197.64802352046, 35744.10639734028, 36228.456573151954, 36245.63754362422, 36246.45630315495, 34305.65694343125, 34938.0, 35004.299914001065, 35009.29981400409, 35242.295154097286, 29930.25174370571, 31485.527717083805, 32104.357912841144, 32291.838540808087, 32459.837700811346, 24782.0, 25233.747662523874, 25596.0, 26175.869120654275, 26264.21207363782], "unit": "ms", "name": "ext.html", "value": 18116.968641798627}, {"lowerIsBetter": false, "replicates": [356.1790073879707, 357.51378125748977, 357.71919043550815, 357.78710172515196, 358.04045158973946, 14260.500882469116, 14412.783808242859, 16403.589910252234, 16711.749323760137, 17414.303427862902, 15579.298931548079, 16344.264508097134, 16732.83267167328, 16758.497245082635, 17058.744118838196, 5277.973610131944, 5419.430959749228, 5423.159410291411, 5423.566114710833, 5424.321959755031, 3783.886483405502, 3882.495275614166, 5341.0, 5421.295231619883, 5763.510101641345, 5791.160281759164, 5823.505002074829, 5848.239728835267, 5853.385394533577, 5854.209681692981, 5646.209530665689, 5739.139129130643, 5789.913151302734, 5798.333191682968, 5820.505257053155, 5062.848114556569, 5077.086124497589, 5085.516875896784, 5095.872603184913, 5123.871903202413, 19443.125059372363, 19457.318993835288, 19565.21739130433, 20299.28952486656, 20332.08505617251, 1984.394759598322, 2020.8080232377902, 2030.7055476955907, 2076.345951025422, 2148.7743786902306, 12509.0, 12513.311767852765, 12762.872371276262, 12778.488860445572, 12828.551000715024, 1632.3470611755274, 1643.5726711055092, 1680.420255012019, 1695.7456381542745, 1780.7952085510074, 59710.40289597092, 60319.39680603226, 60668.69665651688, 61121.6943915282, 61725.69137154285, 6750.966245168743, 6978.197507286727, 6980.546264492792, 7022.157341119098, 7042.823929401703, 8416.579171041423, 8422.0, 8422.24199822019, 8424.705135320235, 8438.620262088221, 5402.0, 5424.484673955968, 5470.617056806065, 5502.697351645698, 5514.420985796514, 5554.305711786027, 5603.467670571289, 5610.943890561124, 5620.4660557247, 5648.15277708347, 3208.871645134215, 3254.1213872254834, 3271.2312606537444, 3283.1463819407127, 3292.3909076820864, 1107.06453047175, 1145.4272863568217, 1157.4907040901976, 1171.8183681529376, 1196.1638884312713, 413.6938665387652, 417.651261196904, 458.3537212530316, 484.79638551808324, 511.9436861945183, 9890.901090989142, 10718.839217411745, 10784.56861725538, 10798.94600527008, 10880.836787448194, 433.0300127713961, 436.9565972998084, 440.053884149082, 447.6620151785381, 458.06783196195585, 5765.827025189251, 5984.461398474158, 5991.7902873399225, 6036.275646922398, 6088.908666370008, 596629.0, 598592.0, 608797.0, 609999.0, 610362.0, 58633.0, 76557.61721191359, 79342.61972140845, 79901.0, 80112.19887801047, 471.2295397025819, 476.25941660717916, 478.23721164742875, 479.4270846338662, 481.1891962043897, 9718.465484398426, 9811.16605088547, 9854.704358869245, 9959.502024898871, 9978.550965206437, 34725.30549388948, 34885.30229395347, 35549.289014220085, 35563.110922226115, 36269.0, 47054.76472617615, 47776.5222347786, 47824.52175478201, 47952.7602361986, 49413.75293123511, 6677.0, 6787.694553745192, 6796.796096117125, 6797.456203503807, 6800.285969973082, 11508.94245528767, 11773.52905883755, 11973.76052478928, 12065.81901271464, 12126.393680316125, 10492.213084018882, 10677.14582833387, 10688.358698478116, 10808.297460665031, 10861.294015888941, 10436.112930400697, 10801.67594972152, 10914.399708016135, 10950.56197752081, 10991.945040274748, 10272.794544109225, 10869.836952445561, 11180.720481988015, 11254.0, 11266.0, 6718.126643536309, 6728.259891412039, 6741.22475915276, 6799.830004249933, 6829.590224586541, 10731.624393146203, 10797.730056748644, 10890.782184356427, 11113.444327783416, 11116.333020018825], "unit": "ms", "name": "jquery.html", "value": 7135.718365954529}, {"lowerIsBetter": false, "replicates": [1311.468855113678, 1430.835453922799, 1501.0918394371406, 1595.306041871786, 1718.3556166437586, 6634.635095069769, 7519.6616152273145, 7791.220877912206, 7796.33731132853, 7798.3761299096, 7529.774106776806, 7622.0853497580365, 7622.77131686049, 7632.503887247339, 7638.045244344457, 1968.0651690446994, 2029.9391018269475, 2034.2676636410881, 2297.6783250344965, 2320.408295884547, 2311.6070268054473, 2364.917227897024, 2367.0886708617136, 2368.3131891751373, 2368.6328619064075, 2295.758945310735, 2306.0, 2356.2577787996725, 2356.599378105726, 2359.091749676378, 1968.4488343263909, 2012.5572374077678, 2293.059845463352, 2336.8481048731865, 2338.789508944203, 2306.1351993002622, 2309.6766452696634, 2310.2145270608075, 2318.1075286015007, 2319.211468100854, 7807.414443916672, 7849.175836537195, 7893.644785984645, 7904.762857114296, 7911.485753426009, 4755.738434386108, 4854.635902307341, 4878.829240976549, 4889.75551222441, 4895.9755201224125, 3135.247540590242, 3158.273597072663, 3191.457452233126, 3202.1194171602997, 3250.089974807058, 1110.8500352452397, 1788.4366424576217, 1801.2434777393526, 1845.1604519943394, 1871.3543827379533, 10525.21060920434, 10626.30928989621, 10676.145908327315, 10705.999999999922, 10718.303310284884, 4194.580541945781, 4248.277792775236, 4309.956900430955, 4313.374560688682, 4316.330968699856, 8779.429337093068, 8783.560821958876, 8797.868031979526, 8816.603252853636, 8818.735437936872, 4804.8798780030775, 4806.134895718735, 4836.347093142451, 4838.395200599925, 4841.9031619367415, 4453.576910193527, 4455.1757924784015, 4456.242438785414, 4456.487503937024, 4458.710183838105, 3469.444888817777, 3516.6659167379057, 3525.206828463575, 3548.8580456781438, 3553.626869178751, 1091.6888686724246, 1109.2124591540096, 1116.5422176907591, 1133.2463911498926, 1133.28602980122, 1009.6869970309081, 1016.0093908439212, 1037.896210378971, 1038.3250886923408, 1170.8829117088223, 6361.427471527585, 7585.127710313274, 7688.115866675292, 7693.49992250502, 7694.307512323806, 704.0003195462456, 704.7357241034612, 735.8417940142788, 735.9705611775576, 738.759903031517, 5769.307683078057, 5781.0, 5840.445157710011, 5845.064789633639, 5867.559933004956, 9513.619455221851, 9594.04059594035, 9678.516074196263, 9694.466804325688, 9703.805923881482, 9282.257419406431, 9520.428774273565, 9542.379745316532, 9568.186704130088, 9580.13778759901, 7266.63666816657, 7313.0, 7315.231900650355, 7320.780376588711, 7323.414126869838, 7025.156981162293, 7109.111361079865, 7119.964400177966, 7143.4999550031, 7425.368843648351, 8182.81349204374, 8445.366597505088, 8464.95767521183, 8484.872726908978, 8510.31917446615, 8428.0, 8475.0, 8592.65629374818, 8666.35002374837, 8711.477311361085, 7129.500934934712, 7186.640667966476, 7192.388646965067, 7199.460040497089, 7202.135743710788, 7632.427567932538, 7702.460827742004, 7734.651940662796, 7743.29647477554, 7752.30229279345, 7096.7516136934955, 7146.071010768567, 7183.8563228736175, 7278.708851646086, 7369.336759691653, 7093.432525398059, 7108.573485590881, 7132.928670713226, 7236.565806051653, 7307.488475806856, 7253.492255542273, 7293.0519032525435, 7297.160826504807, 7301.926980730124, 7307.2327405621645, 5523.944760552343, 6157.722902469489, 6632.867342653217, 6672.399484046459, 6690.765823196165, 6692.866142677217, 6697.7655782047395, 6721.731130754911, 6734.4612431004425, 6736.393724564813], "unit": "ms", "name": "mootools.html", "value": 4512.354472490619}, {"lowerIsBetter": false, "replicates": [336.0506568942737, 336.5641494264927, 338.38582971906004, 345.8720273498805, 347.1148571143585, 5836.0, 5958.851028724284, 5997.6401415915025, 6010.909836352458, 6048.909266360997, 5812.360640329561, 5940.34656187819, 5953.58324917256, 5958.136070269808, 5960.22517072781, 4590.265557510799, 4621.214393553088, 4636.0, 4636.698614590041, 4663.2538793793, 4452.243118669834, 4536.818527258923, 4540.523245059271, 4647.8838029049375, 4660.019491716024, 4561.224591819382, 4566.680332376735, 4584.472785629662, 4598.126355992367, 4612.723236605798, 4575.4051973243595, 4580.381648477446, 4591.1965406053805, 4609.492955774862, 4621.838235661769, 4058.655014323786, 4062.329715596923, 4062.350023996176, 4067.3695577185586, 4067.779666100158, 5581.358143813432, 5632.04255276604, 5651.886962260732, 5664.54683625309, 5670.064439367499, 5361.731913404353, 5368.32895888014, 5373.892522149574, 5375.623706340558, 5378.354597448292, 6070.119832624245, 6328.557001009931, 6332.461740752042, 6334.714937827763, 6337.588056776295, 4352.086061926999, 4417.536158703322, 4487.461504619434, 4491.23648979671, 4496.2581174106235, 6412.39082287182, 6528.575642583264, 6532.3467653234775, 6541.247756508015, 6546.18172728409, 4605.677602567788, 4610.723356598614, 4610.97694511532, 4611.723296602215, 4617.930731039037, 4552.544745525421, 4662.0, 4669.042846216517, 4684.789184486706, 4694.2723877799, 5345.732713364317, 5348.465153484621, 5349.545288650431, 5353.250544923714, 5353.866153346197, 6369.649669268235, 6372.865090194744, 6376.011718183689, 6381.074744162163, 6384.201974753156, 1632.755086736999, 1638.8443097905679, 1641.3926847066423, 1641.8671116929281, 1642.6468309313555, 1079.9730006749737, 1107.5514416661265, 1111.6498303034518, 1112.6495154026618, 1114.2590177532013, 6150.7847225346895, 6151.2618485781095, 6156.907646385308, 6162.7226774795245, 6163.3528479509905, 6559.836004099936, 6575.276719560845, 6576.342365763481, 6580.901286480706, 6581.407673309425, 5997.0, 6153.1693221415435, 6158.692065396713, 6170.598911070766, 6177.498113264135, 3543.3976224041976, 3567.090391950036, 3568.964310356915, 3569.714422846166, 3574.0350105471375, 6608.900866487006, 6633.303503132198, 6636.303188165173, 6639.369259920397, 6657.833554161185, 6721.563098398588, 6760.614074114795, 6762.323767623198, 6767.966160169266, 6773.6613169341335, 6530.575512591667, 6827.556208846409, 6835.726570937206, 6881.827954301082, 6887.827804304932, 6374.107624932421, 6466.159399278252, 6545.116409284686, 6658.1344425224415, 6672.0, 6492.577982431127, 6509.381608747161, 6522.510811689237, 6525.021246813016, 6532.510061745483, 6684.966575167093, 6691.899621505779, 6696.19645642526, 6714.194296684429, 6858.142732158481, 4411.713238639478, 4490.77546122686, 4518.390017347616, 4525.909481810279, 4543.454785425638, 6626.900596491153, 6634.369734875179, 6637.568558043712, 6642.6014439133805, 6645.767398141042, 6462.224533056064, 6469.320721324381, 6471.708773105316, 6472.708728107153, 6473.741050358121, 6288.182536270256, 6458.838529036811, 6460.773872914613, 6462.935370646422, 6465.1595292611655, 6291.245050593958, 6303.180586523723, 6313.652749098844, 6323.430891219812, 6331.366863313816, 6494.350564943468, 6503.869922601616, 6505.121808555785, 6505.967470162619, 6508.7721929734125, 6212.782552610637, 6327.430531252209, 6333.36666333363, 6339.714712838026, 6340.873182536416], "unit": "ms", "name": "prototype.html", "value": 4823.142879786895}, {"lowerIsBetter": false, "replicates": [759.8290384663455, 764.0716529416758, 767.3554214459853, 838.6393850644221, 839.8212764685665, 13695.109817861832, 13927.0, 13928.721425571495, 13961.44154233832, 13961.650958726024, 12915.612531624067, 12983.48066077358, 14248.928755356235, 14653.340599673014, 14680.779788303184, 807.6971135824066, 817.2562967699395, 819.4960099538771, 822.411975437562, 824.4640983360833, 808.4421748993205, 812.7764864662206, 818.9058258300282, 819.4100247821559, 822.9094799572042, 853.8761879527465, 866.9393142480029, 868.8175483148515, 869.4783130121908, 869.5087275689247, 855.5807654249404, 863.9395242333039, 864.5029108262743, 867.2974890338783, 867.6529388244721, 620.5625034350771, 622.757124721359, 624.3288464900205, 625.2122325869392, 626.9341719119518, 13570.864291357058, 13801.723965520634, 13936.954728395309, 13963.58109256724, 13974.58076257714, 10156.187504999582, 10308.94845525775, 10546.578136874516, 10806.18953578477, 10887.727806804814, 9079.818403631956, 9402.576884040234, 9442.811143777086, 9590.712278631652, 9714.125728684452, 3052.8320942348164, 3056.3581647853757, 3107.7979931304617, 3109.875604975798, 3122.625284965796, 45414.0, 46050.76974615139, 46112.0, 46124.30813537799, 46293.0, 7196.10048743907, 7288.781336559911, 7299.160596531361, 7463.104427468738, 7498.512596681198, 12008.879911200951, 12078.335691536875, 12083.214591051554, 12719.427625756864, 12761.0, 6576.145101136822, 6605.339466053356, 6836.4530837532875, 6846.246912839583, 6940.583564986117, 4105.91788164235, 4109.609587089221, 4217.472815898012, 4235.97882010588, 4240.088380998101, 2831.617731606248, 2868.225579093633, 2875.3386721053857, 2875.7699384049224, 2876.7267109624554, 453.33359960857484, 459.0612198054986, 464.30818081058976, 465.36477707928435, 466.51249444330756, 616.3189675408698, 622.7602373086395, 624.643952946816, 659.0871642774696, 669.8928171492538, 8146.0, 8259.504429734236, 8265.669373225124, 8340.416170868102, 8442.662293508314, 646.5409559212917, 651.8435575461855, 656.8357910522369, 661.7551505942832, 664.773976847874, 3769.0, 4003.6396724294955, 4087.448194493705, 4235.2800023996, 4357.346398040319, 56584.43415565792, 56617.716911416006, 57913.420865791646, 58184.41815581875, 58242.7087864558, 50957.49042509602, 51386.0, 51475.0, 52366.73816630969, 52706.20940685893, 40453.0, 40746.0, 45460.318095227936, 46120.0, 50735.74632126742, 8101.594920253846, 8442.957785211034, 8485.95757021211, 8553.187447192508, 8736.519491428033, 30741.0, 36076.0, 36441.17794110337, 36923.26153476969, 37154.0, 46473.302900457194, 46848.297275541576, 46884.29673554831, 48525.0, 48542.757286213346, 7561.319481246494, 7591.734289299848, 7621.0, 7635.274648908345, 7719.961400193188, 10637.04334986607, 10885.727856803644, 10977.615783447542, 11003.944980275368, 11169.664910052712, 10047.497625118862, 10194.949025254826, 10243.795124097625, 10245.334053286513, 10293.3823970562, 10034.397936123856, 10419.791604167722, 10423.270371073952, 10465.633702820669, 10698.946505267424, 10233.437160956219, 10598.15214782831, 10683.679489615324, 10739.087177589992, 11212.66362009141, 9277.443353398818, 9402.764930876783, 9662.903370966482, 9686.660966866126, 9790.26573007013, 8407.53758543286, 8608.61261243258, 8869.911300886908, 9110.134537218953, 9306.0], "unit": "ms", "name": "yui.html", "value": 5934.237795993753}], "name": "dromaeo_css", "value": 6718.041989177656}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 104.0, 109.0, 110.0, 111.0, 99.0, 111.0, 110.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 108.3}, {"lowerIsBetter": true, "replicates": [153.0, 124.0, 149.0, 166.0, 129.0, 155.0, 149.0, 130.0, 166.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.4}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 163.0, 161.0, 160.0, 160.0, 160.0, 163.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 80.0, 95.0, 72.0, 72.0, 73.0, 108.0, 88.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 80.2}, {"lowerIsBetter": true, "replicates": [90.0, 90.0, 142.0, 90.0, 90.0, 91.0, 143.0, 89.0, 91.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 105.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 97.0, 95.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 58.0, 56.0, 56.0, 56.0, 60.0, 64.0, 54.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 57.1}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 68.0, 70.0, 69.0, 69.0, 69.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 85.0, 85.0, 84.0, 86.0, 85.0, 93.0, 85.0, 87.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [124.0, 119.0, 126.0, 117.0, 122.0, 120.0, 117.0, 115.0, 118.0, 124.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.2}, {"lowerIsBetter": true, "replicates": [146.0, 153.0, 155.0, 152.0, 152.0, 142.0, 151.0, 151.0, 152.0, 141.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 149.5}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 67.0, 68.0, 68.0, 73.0, 68.0, 68.0, 69.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1499.9000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.18537859007833], "unit": "score", "name": "Richards", "value": 216.33065600000006}, {"lowerIsBetter": false, "replicates": [194.47685725398676], "unit": "score", "name": "DeltaBlue", "value": 339.9787560000001}, {"lowerIsBetter": false, "replicates": [285.7959416976279], "unit": "score", "name": "Encrypt", "value": 931.3673189999998}, {"lowerIsBetter": false, "replicates": [5040.201005025126], "unit": "score", "name": "Decrypt", "value": 52.81158424725827}, {"lowerIsBetter": false, "replicates": [1104.9723756906078], "unit": "score", "name": "RayTrace", "value": 669.6900450000003}, {"lowerIsBetter": false, "replicates": [779.423226812159], "unit": "score", "name": "Earley", "value": 855.072029}, {"lowerIsBetter": false, "replicates": [12156.626506024097], "unit": "score", "name": "Boyer", "value": 54.82302180376615}, {"lowerIsBetter": false, "replicates": [26500.0], "unit": "score", "name": "RegExp", "value": 34.37679245283018}, {"lowerIsBetter": false, "replicates": [578.368999421631], "unit": "score", "name": "Splay", "value": 140.89793900000006}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21107.04708096197}]} 10:03:57 INFO - RETURN: dromaeo_css: 6718.04 10:03:57 INFO - RETURN: kraken: 1499.90 10:03:57 INFO - RETURN: v8_7: 21107.05 10:03:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "21107.05"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1499.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6718.04"}}} 10:03:57 INFO - Return code: 0 10:03:57 INFO - # TBPL SUCCESS # 10:03:57 INFO - Running post-action listener: _resource_record_post_action 10:03:57 INFO - Running post-run listener: _resource_record_post_run 10:03:58 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 507453440; Read time: 8; Write time: 431444 10:03:58 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 231354368; Read time: 0; Write time: 259480 10:03:58 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 266321920; Read time: 8; Write time: 141088 10:03:58 INFO - Running post-run listener: _upload_blobber_files 10:03:58 INFO - Blob upload gear active. 10:03:58 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:03:58 INFO - Copying logs to upload dir... 10:03:58 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1291.571795 ========= master_lag: 4.73 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 36 secs) (at 2015-11-19 10:04:02.817012) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 10:04:02.820542) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1447954897.489494-1700905094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010278 build_url: 'https://queue.taskcluster.net/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 10:04:02.843944) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 10:04:02.844306) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1447954897.489494-1700905094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004610 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 10:04:02.894027) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 10:04:02.894375) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 10:04:02.894690) ========= ========= Total master_lag: 4.95 =========