builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1447394795.16 results: success (0) buildid: 20151112203045 builduid: 8ad16f0e205a41779d19fde93b173b2b revision: 4b2ec935bc99bc505776190210b11dfe552bd041 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:35.163682) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:35.164427) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:35.164944) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1447394334.150226-603385331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005544 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:35.216192) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:35.216746) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:35.380645) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:35.380984) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1447394334.150226-603385331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.036653 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:35.462297) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:35.463209) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:35.463721) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:35.464191) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1447394334.150226-603385331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-12 22:06:35-- 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% 222M=0s 2015-11-12 22:06:35 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.289936 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:35.787579) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:35.787909) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1447394334.150226-603385331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.097621 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:35.908863) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:35.909209) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4b2ec935bc99bc505776190210b11dfe552bd041 --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 4b2ec935bc99bc505776190210b11dfe552bd041 --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=d7d9c069d1ebe471abe975fc000001d9-1447394334.150226-603385331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-12 22:06:35,970 truncating revision to first 12 chars 2015-11-12 22:06:35,970 Setting DEBUG logging. 2015-11-12 22:06:35,970 attempt 1/10 2015-11-12 22:06:35,970 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4b2ec935bc99?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-12 22:06:36,224 unpacking tar archive at: fx-team-4b2ec935bc99/testing/mozharness/ program finished with exit code 0 elapsedTime=0.519109 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:36.443814) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:36.444147) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:36.455586) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:36.455965) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:36.456470) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-11-12 22:06:36.456940) ========= /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=d7d9c069d1ebe471abe975fc000001d9-1447394334.150226-603385331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:06:36 INFO - MultiFileLogger online at 20151112 22:06:36 in /builds/slave/test-pgo 22:06:36 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 22:06:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:06:36 INFO - {'append_to_log': False, 22:06:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:06:36 INFO - 'blob_upload_branch': 'Fx-Team', 22:06:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:06:36 INFO - 'branch': 'Fx-Team', 22:06:36 INFO - 'buildbot_json_path': 'buildprops.json', 22:06:36 INFO - 'config_files': ('talos/linux_config.py',), 22:06:36 INFO - 'default_actions': ('clobber', 22:06:36 INFO - 'read-buildbot-config', 22:06:36 INFO - 'download-and-extract', 22:06:36 INFO - 'populate-webroot', 22:06:36 INFO - 'create-virtualenv', 22:06:36 INFO - 'install', 22:06:36 INFO - 'run-tests'), 22:06:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:06:36 INFO - 'download_minidump_stackwalk': True, 22:06:36 INFO - 'download_symbols': 'ondemand', 22:06:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:06:36 INFO - 'tooltool.py': '/tools/tooltool.py', 22:06:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:06:36 INFO - '/tools/misc-python/virtualenv.py')}, 22:06:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:06:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:06:36 INFO - 'installer_path': 'installer.exe', 22:06:36 INFO - 'log_level': 'info', 22:06:36 INFO - 'log_name': 'talos', 22:06:36 INFO - 'log_to_console': True, 22:06:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:06:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:06:36 INFO - 'opt_config_files': (), 22:06:36 INFO - 'pip_index': False, 22:06:36 INFO - 'sps_profile': False, 22:06:36 INFO - 'sps_profile_interval': 0, 22:06:36 INFO - 'suite': 'dromaeojs', 22:06:36 INFO - 'system_bits': '64', 22:06:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:06:36 INFO - 'title': 'talos-linux64-ix-068', 22:06:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:06:36 INFO - 'use_talos_json': True, 22:06:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:06:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:06:36 INFO - 'work_dir': 'build'} 22:06:36 INFO - ##### 22:06:36 INFO - ##### Running clobber step. 22:06:36 INFO - ##### 22:06:36 INFO - Running pre-action listener: _resource_record_pre_action 22:06:36 INFO - Running main action method: clobber 22:06:36 INFO - rmtree: /builds/slave/test-pgo/build 22:06:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:06:41 INFO - Running post-action listener: _resource_record_post_action 22:06:41 INFO - ##### 22:06:41 INFO - ##### Running read-buildbot-config step. 22:06:41 INFO - ##### 22:06:41 INFO - Running pre-action listener: _resource_record_pre_action 22:06:41 INFO - Running main action method: read_buildbot_config 22:06:41 INFO - Using buildbot properties: 22:06:41 INFO - { 22:06:41 INFO - "properties": { 22:06:41 INFO - "buildnumber": 779, 22:06:41 INFO - "product": "firefox", 22:06:41 INFO - "script_repo_revision": "production", 22:06:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:06:41 INFO - "repository": "", 22:06:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 22:06:41 INFO - "buildid": "20151112203045", 22:06:41 INFO - "slavename": "talos-linux64-ix-068", 22:06:41 INFO - "pgo_build": "True", 22:06:41 INFO - "basedir": "/builds/slave/test-pgo", 22:06:41 INFO - "project": "", 22:06:41 INFO - "platform": "ubuntu64_hw", 22:06:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:06:41 INFO - "slavebuilddir": "test", 22:06:41 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:06:41 INFO - "branch": "fx-team", 22:06:41 INFO - "repo_path": "integration/fx-team", 22:06:41 INFO - "stage_platform": "linux64-pgo", 22:06:41 INFO - "builduid": "8ad16f0e205a41779d19fde93b173b2b", 22:06:41 INFO - "revision": "4b2ec935bc99bc505776190210b11dfe552bd041" 22:06:41 INFO - }, 22:06:41 INFO - "sourcestamp": { 22:06:41 INFO - "repository": "", 22:06:41 INFO - "hasPatch": false, 22:06:41 INFO - "project": "", 22:06:41 INFO - "branch": "fx-team-linux64-pgo-talos", 22:06:41 INFO - "changes": [ 22:06:41 INFO - { 22:06:41 INFO - "category": null, 22:06:41 INFO - "files": [ 22:06:41 INFO - { 22:06:41 INFO - "url": null, 22:06:41 INFO - "name": "https://queue.taskcluster.net/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 22:06:41 INFO - } 22:06:41 INFO - ], 22:06:41 INFO - "repository": "", 22:06:41 INFO - "rev": "4b2ec935bc99bc505776190210b11dfe552bd041", 22:06:41 INFO - "who": "sendchange", 22:06:41 INFO - "when": 1447394770, 22:06:41 INFO - "number": 6656415, 22:06:41 INFO - "comments": "", 22:06:41 INFO - "project": "", 22:06:41 INFO - "at": "Thu 12 Nov 2015 22:06:10", 22:06:41 INFO - "branch": "fx-team-linux64-pgo-talos", 22:06:41 INFO - "revlink": "", 22:06:41 INFO - "properties": [ 22:06:41 INFO - [ 22:06:41 INFO - "buildid", 22:06:41 INFO - "20151112203045", 22:06:41 INFO - "Change" 22:06:41 INFO - ], 22:06:41 INFO - [ 22:06:41 INFO - "builduid", 22:06:41 INFO - "8ad16f0e205a41779d19fde93b173b2b", 22:06:41 INFO - "Change" 22:06:41 INFO - ], 22:06:41 INFO - [ 22:06:41 INFO - "pgo_build", 22:06:41 INFO - "True", 22:06:41 INFO - "Change" 22:06:41 INFO - ] 22:06:41 INFO - ], 22:06:41 INFO - "revision": "4b2ec935bc99bc505776190210b11dfe552bd041" 22:06:41 INFO - } 22:06:41 INFO - ], 22:06:41 INFO - "revision": "4b2ec935bc99bc505776190210b11dfe552bd041" 22:06:41 INFO - } 22:06:41 INFO - } 22:06:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 22:06:41 INFO - Running post-action listener: _resource_record_post_action 22:06:41 INFO - ##### 22:06:41 INFO - ##### Running download-and-extract step. 22:06:41 INFO - ##### 22:06:41 INFO - Running pre-action listener: _resource_record_pre_action 22:06:41 INFO - Running main action method: download_and_extract 22:06:41 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:06:41 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')]} 22:06:41 INFO - https://queue.taskcluster.net/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:06:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/test_packages.json 22:06:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/test_packages.json 22:06:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:06:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:06:48 INFO - Downloaded 1302 bytes. 22:06:48 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:06:48 INFO - Using the following test package requirements: 22:06:48 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:06:48 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:06:48 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:48 INFO - u'jsshell-linux-x86_64.zip'], 22:06:48 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:06:48 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:06:48 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:06:48 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:06:48 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:06:48 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:06:48 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:06:48 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:06:48 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')]} 22:06:48 INFO - https://queue.taskcluster.net/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:06:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:06:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:06:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/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 22:06:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/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 22:06:58 INFO - Downloaded 22443432 bytes. 22:06:58 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 22:06:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:06:58 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 22:06:59 INFO - Return code: 0 22:06:59 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 22:06:59 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')]} 22:06:59 INFO - https://queue.taskcluster.net/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:06:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:06:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:06:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/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 22:06:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/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 22:07:01 INFO - Downloaded 22443432 bytes. 22:07:01 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 22:07:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:07:01 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 22:07:02 INFO - Return code: 0 22:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:02 INFO - https://queue.taskcluster.net/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:07:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:07:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:07:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/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 22:07:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/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 22:07:03 INFO - Downloaded 11131693 bytes. 22:07:03 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 22:07:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:07:03 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 22:07:03 INFO - Return code: 0 22:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:03 INFO - https://queue.taskcluster.net/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:07:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:07:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:07:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/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 22:07:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/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 22:07:05 INFO - Downloaded 57166214 bytes. 22:07:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:07:05 INFO - mkdir: /builds/slave/test-pgo/properties 22:07:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:07:05 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:07:05 INFO - Contents: 22:07:05 INFO - build_url:https://queue.taskcluster.net/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:07:05 INFO - Running post-action listener: _resource_record_post_action 22:07:05 INFO - Running post-action listener: set_extra_try_arguments 22:07:05 INFO - ##### 22:07:05 INFO - ##### Running populate-webroot step. 22:07:05 INFO - ##### 22:07:05 INFO - Running pre-action listener: _resource_record_pre_action 22:07:05 INFO - Running main action method: populate_webroot 22:07:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:07:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:07:05 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 22:07:05 INFO - '../fennec_ids.txt'], 22:07:05 INFO - 'tests': ['tcheck2']}, 22:07:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:07:05 INFO - '--tppagecycles', 22:07:05 INFO - '7'], 22:07:05 INFO - 'tests': ['tsvgm']}}, 22:07:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:07:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:07:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:07:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:07:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:07:05 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:07:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:07:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:05 INFO - 'talos_options': ['--e10s'], 22:07:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:07:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:05 INFO - 'tests': ['damp', 'tps']}, 22:07:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:05 INFO - 'talos_options': ['--e10s'], 22:07:05 INFO - 'tests': ['damp', 'tps']}, 22:07:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:07:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:07:05 INFO - 'other': {'tests': ['a11yr', 22:07:05 INFO - 'ts_paint', 22:07:05 INFO - 'tpaint', 22:07:05 INFO - 'sessionrestore', 22:07:05 INFO - 'sessionrestore_no_auto_restore']}, 22:07:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:07:05 INFO - 'tests': ['a11yr', 22:07:05 INFO - 'ts_paint', 22:07:05 INFO - 'tpaint', 22:07:05 INFO - 'sessionrestore', 22:07:05 INFO - 'sessionrestore_no_auto_restore']}, 22:07:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:07:05 INFO - 'tests': ['a11yr', 22:07:05 INFO - 'ts_paint', 22:07:05 INFO - 'tpaint', 22:07:05 INFO - 'sessionrestore', 22:07:05 INFO - 'sessionrestore_no_auto_restore']}, 22:07:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:07:05 INFO - 'tests': ['a11yr', 22:07:05 INFO - 'ts_paint', 22:07:05 INFO - 'tpaint', 22:07:05 INFO - 'sessionrestore', 22:07:05 INFO - 'sessionrestore_no_auto_restore']}, 22:07:05 INFO - 'other_l64': {'tests': ['a11yr', 22:07:05 INFO - 'ts_paint', 22:07:05 INFO - 'tpaint', 22:07:05 INFO - 'sessionrestore', 22:07:05 INFO - 'sessionrestore_no_auto_restore']}, 22:07:05 INFO - 'other_nol64': {'tests': ['a11yr', 22:07:05 INFO - 'ts_paint', 22:07:05 INFO - 'tpaint', 22:07:05 INFO - 'sessionrestore', 22:07:05 INFO - 'sessionrestore_no_auto_restore']}, 22:07:05 INFO - 'svgr': {'tests': ['tsvgx', 22:07:05 INFO - 'tsvgr_opacity', 22:07:05 INFO - 'tart', 22:07:05 INFO - 'tscrollx', 22:07:05 INFO - 'cart']}, 22:07:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:07:05 INFO - 'tests': ['tsvgx', 22:07:05 INFO - 'tsvgr_opacity', 22:07:05 INFO - 'tart', 22:07:05 INFO - 'tscrollx', 22:07:05 INFO - 'cart']}, 22:07:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:05 INFO - 'tests': ['tp5o']}, 22:07:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:05 INFO - 'talos_options': ['--e10s'], 22:07:05 INFO - 'tests': ['tp5o']}, 22:07:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:05 INFO - 'talos_options': ['--xperf_path', 22:07:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:07:05 INFO - 'tests': ['tp5n']}, 22:07:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:05 INFO - 'talos_options': ['--e10s', 22:07:05 INFO - '--xperf_path', 22:07:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:07:05 INFO - 'tests': ['tp5n']}}, 22:07:05 INFO - 'talos.zip': {'path': '', 22:07:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:07:05 INFO - Running post-action listener: _resource_record_post_action 22:07:05 INFO - ##### 22:07:05 INFO - ##### Running create-virtualenv step. 22:07:05 INFO - ##### 22:07:05 INFO - Running pre-action listener: _resource_record_pre_action 22:07:05 INFO - Running main action method: create_virtualenv 22:07:05 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:07:05 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 22:07:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:07:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:07:05 INFO - Using real prefix '/usr' 22:07:05 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:07:05 INFO - Installing distribute.............................................................................................................................................................................................done. 22:07:08 INFO - Installing pip.................done. 22:07:08 INFO - Return code: 0 22:07:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:07:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0dcd830c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23636c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24246e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245aa90>, '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 0x24acf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ad2e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1447394334.150226-603385331', '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 22:07:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 22:07:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:07:08 INFO - Using env: {'DISPLAY': ':0', 22:07:08 INFO - 'HOME': '/home/cltbld', 22:07:08 INFO - 'LANG': 'en_US.UTF-8', 22:07:08 INFO - 'LANGUAGE': 'en_US:en', 22:07:08 INFO - 'LOGNAME': 'cltbld', 22:07:08 INFO - 'MAIL': '/var/mail/cltbld', 22:07:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:08 INFO - 'MOZ_NO_REMOTE': '1', 22:07:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:08 INFO - 'NO_EM_RESTART': '1', 22:07:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:08 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:08 INFO - 'SHELL': '/bin/bash', 22:07:08 INFO - 'SHLVL': '1', 22:07:08 INFO - 'TERM': 'linux', 22:07:08 INFO - 'TMOUT': '86400', 22:07:08 INFO - 'USER': 'cltbld', 22:07:08 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447394334.150226-603385331', 22:07:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:08 INFO - '_': '/tools/buildbot/bin/python'} 22:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:09 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 22:07:09 INFO - Cleaning up... 22:07:09 INFO - Return code: 0 22:07:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:07: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')]} 22:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07: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')]} 22:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:09 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 0x7f0dcd830c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23636c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24246e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245aa90>, '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 0x24acf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ad2e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1447394334.150226-603385331', '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 22:07:09 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 22:07:09 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 22:07:09 INFO - Using env: {'DISPLAY': ':0', 22:07:09 INFO - 'HOME': '/home/cltbld', 22:07:09 INFO - 'LANG': 'en_US.UTF-8', 22:07:09 INFO - 'LANGUAGE': 'en_US:en', 22:07:09 INFO - 'LOGNAME': 'cltbld', 22:07:09 INFO - 'MAIL': '/var/mail/cltbld', 22:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:09 INFO - 'MOZ_NO_REMOTE': '1', 22:07:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:09 INFO - 'NO_EM_RESTART': '1', 22:07:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:09 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:09 INFO - 'SHELL': '/bin/bash', 22:07:09 INFO - 'SHLVL': '1', 22:07:09 INFO - 'TERM': 'linux', 22:07:09 INFO - 'TMOUT': '86400', 22:07:09 INFO - 'USER': 'cltbld', 22:07:09 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447394334.150226-603385331', 22:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:09 INFO - '_': '/tools/buildbot/bin/python'} 22:07:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:10 INFO - Downloading/unpacking psutil>=0.7.1 22:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:11 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:07:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:07:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:07:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:07:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:07:11 INFO - Installing collected packages: psutil 22:07:11 INFO - Running setup.py install for psutil 22:07:11 INFO - building 'psutil._psutil_linux' extension 22:07:11 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 22:07:12 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 22:07:12 INFO - building 'psutil._psutil_posix' extension 22:07:12 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 22:07:12 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 22:07:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:07:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:07:13 INFO - Successfully installed psutil 22:07:13 INFO - Cleaning up... 22:07:14 INFO - Return code: 0 22:07:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f0dcd830c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23636c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24246e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245aa90>, '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 0x24acf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ad2e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1447394334.150226-603385331', '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 22:07:14 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 22:07:14 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 22:07:14 INFO - Using env: {'DISPLAY': ':0', 22:07:14 INFO - 'HOME': '/home/cltbld', 22:07:14 INFO - 'LANG': 'en_US.UTF-8', 22:07:14 INFO - 'LANGUAGE': 'en_US:en', 22:07:14 INFO - 'LOGNAME': 'cltbld', 22:07:14 INFO - 'MAIL': '/var/mail/cltbld', 22:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:14 INFO - 'MOZ_NO_REMOTE': '1', 22:07:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:14 INFO - 'NO_EM_RESTART': '1', 22:07:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:14 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:14 INFO - 'SHELL': '/bin/bash', 22:07:14 INFO - 'SHLVL': '1', 22:07:14 INFO - 'TERM': 'linux', 22:07:14 INFO - 'TMOUT': '86400', 22:07:14 INFO - 'USER': 'cltbld', 22:07:14 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447394334.150226-603385331', 22:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:14 INFO - '_': '/tools/buildbot/bin/python'} 22:07:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:07:14 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 22:07:14 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 22:07:14 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 22:07:14 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 22:07:14 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 22:07:14 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 22:07:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:07:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:07:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:07:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:07:15 INFO - Installing collected packages: mozsystemmonitor 22:07:15 INFO - Running setup.py install for mozsystemmonitor 22:07:16 INFO - Successfully installed mozsystemmonitor 22:07:16 INFO - Cleaning up... 22:07:16 INFO - Return code: 0 22:07:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:07:16 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')]} 22:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:16 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')]} 22:07:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:16 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 0x7f0dcd830c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23636c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24246e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245aa90>, '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 0x24acf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ad2e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1447394334.150226-603385331', '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 22:07:16 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 22:07:16 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 22:07:16 INFO - Using env: {'DISPLAY': ':0', 22:07:16 INFO - 'HOME': '/home/cltbld', 22:07:16 INFO - 'LANG': 'en_US.UTF-8', 22:07:16 INFO - 'LANGUAGE': 'en_US:en', 22:07:16 INFO - 'LOGNAME': 'cltbld', 22:07:16 INFO - 'MAIL': '/var/mail/cltbld', 22:07:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:16 INFO - 'MOZ_NO_REMOTE': '1', 22:07:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:16 INFO - 'NO_EM_RESTART': '1', 22:07:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:16 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:16 INFO - 'SHELL': '/bin/bash', 22:07:16 INFO - 'SHLVL': '1', 22:07:16 INFO - 'TERM': 'linux', 22:07:16 INFO - 'TMOUT': '86400', 22:07:16 INFO - 'USER': 'cltbld', 22:07:16 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447394334.150226-603385331', 22:07:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:16 INFO - '_': '/tools/buildbot/bin/python'} 22:07:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:16 INFO - Downloading/unpacking blobuploader==1.2.4 22:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:17 INFO - Downloading blobuploader-1.2.4.tar.gz 22:07:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:07:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:07:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:07: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 22:07: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 22:07: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 22:07: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 22:07: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 22:07: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 22:07:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:07:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:07:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:07: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 22:07: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 22:07: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 22:07: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 22:07: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 22:07: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 22:07:18 INFO - Downloading docopt-0.6.1.tar.gz 22:07:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:07:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:07:18 INFO - Installing collected packages: blobuploader, requests, docopt 22:07:18 INFO - Running setup.py install for blobuploader 22:07:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:07:18 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:07:18 INFO - Running setup.py install for requests 22:07:19 INFO - Running setup.py install for docopt 22:07:19 INFO - Successfully installed blobuploader requests docopt 22:07:19 INFO - Cleaning up... 22:07:19 INFO - Return code: 0 22:07:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:07:19 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')]} 22:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:19 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')]} 22:07:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:19 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 0x7f0dcd830c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23636c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24246e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245aa90>, '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 0x24acf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ad2e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1447394334.150226-603385331', '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 22:07:19 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 22:07:19 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 22:07:19 INFO - Using env: {'DISPLAY': ':0', 22:07:19 INFO - 'HOME': '/home/cltbld', 22:07:19 INFO - 'LANG': 'en_US.UTF-8', 22:07:19 INFO - 'LANGUAGE': 'en_US:en', 22:07:19 INFO - 'LOGNAME': 'cltbld', 22:07:19 INFO - 'MAIL': '/var/mail/cltbld', 22:07:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:19 INFO - 'MOZ_NO_REMOTE': '1', 22:07:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:19 INFO - 'NO_EM_RESTART': '1', 22:07:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:19 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:19 INFO - 'SHELL': '/bin/bash', 22:07:19 INFO - 'SHLVL': '1', 22:07:19 INFO - 'TERM': 'linux', 22:07:19 INFO - 'TMOUT': '86400', 22:07:19 INFO - 'USER': 'cltbld', 22:07:19 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447394334.150226-603385331', 22:07:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:19 INFO - '_': '/tools/buildbot/bin/python'} 22:07:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:07:19 INFO - Running setup.py (path:/tmp/pip-uNAh5n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:07:19 INFO - Running setup.py (path:/tmp/pip-v4iFyC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:07:19 INFO - Running setup.py (path:/tmp/pip-jzZRFm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:07:19 INFO - Running setup.py (path:/tmp/pip-CVKkjv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:07:19 INFO - Running setup.py (path:/tmp/pip-UWodYl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:07:19 INFO - Running setup.py (path:/tmp/pip-eYTB4W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:07:19 INFO - Running setup.py (path:/tmp/pip-zKJPcm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:07:19 INFO - Running setup.py (path:/tmp/pip-V_nbhS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:07:20 INFO - Running setup.py (path:/tmp/pip-SnKne8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:07:20 INFO - Running setup.py (path:/tmp/pip-BnVoEe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:07:20 INFO - Running setup.py (path:/tmp/pip-IbOetj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:07:20 INFO - Running setup.py (path:/tmp/pip-neTgkZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:07:20 INFO - Running setup.py (path:/tmp/pip-Wj24az-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:07:20 INFO - Running setup.py (path:/tmp/pip-4Td7hW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:07:20 INFO - Running setup.py (path:/tmp/pip-HPTEbD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:07:20 INFO - Running setup.py (path:/tmp/pip-CF272Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:07:20 INFO - Running setup.py (path:/tmp/pip-BwbXDz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:07:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:07:20 INFO - Running setup.py install for manifestparser 22:07:20 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:07:20 INFO - Running setup.py install for mozcrash 22:07:20 INFO - Running setup.py install for mozdebug 22:07:21 INFO - Running setup.py install for mozdevice 22:07:21 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:07:21 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:07:21 INFO - Running setup.py install for mozfile 22:07:21 INFO - Running setup.py install for mozhttpd 22:07:21 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:07:21 INFO - Running setup.py install for mozinfo 22:07:21 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:07:21 INFO - Running setup.py install for mozInstall 22:07:21 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:07:21 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:07:21 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:07:21 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:07:21 INFO - Running setup.py install for mozleak 22:07:21 INFO - Running setup.py install for mozlog 22:07:21 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:07:21 INFO - Running setup.py install for moznetwork 22:07:21 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:07:21 INFO - Running setup.py install for mozprocess 22:07:21 INFO - Running setup.py install for mozprofile 22:07:22 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:07:22 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:07:22 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:07:22 INFO - Running setup.py install for mozrunner 22:07:22 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:07:22 INFO - Running setup.py install for mozscreenshot 22:07:22 INFO - Running setup.py install for moztest 22:07:22 INFO - Running setup.py install for mozversion 22:07:22 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:07:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:07:22 INFO - Cleaning up... 22:07:22 INFO - Return code: 0 22:07:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:07:22 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')]} 22:07:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:22 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')]} 22:07:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:22 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 0x7f0dcd830c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23636c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24246e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245aa90>, '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 0x24acf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ad2e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1447394334.150226-603385331', '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 22:07:22 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 22:07:22 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 22:07:22 INFO - Using env: {'DISPLAY': ':0', 22:07:22 INFO - 'HOME': '/home/cltbld', 22:07:22 INFO - 'LANG': 'en_US.UTF-8', 22:07:22 INFO - 'LANGUAGE': 'en_US:en', 22:07:22 INFO - 'LOGNAME': 'cltbld', 22:07:22 INFO - 'MAIL': '/var/mail/cltbld', 22:07:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:22 INFO - 'MOZ_NO_REMOTE': '1', 22:07:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:22 INFO - 'NO_EM_RESTART': '1', 22:07:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:22 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:22 INFO - 'SHELL': '/bin/bash', 22:07:22 INFO - 'SHLVL': '1', 22:07:22 INFO - 'TERM': 'linux', 22:07:22 INFO - 'TMOUT': '86400', 22:07:22 INFO - 'USER': 'cltbld', 22:07:22 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447394334.150226-603385331', 22:07:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:22 INFO - '_': '/tools/buildbot/bin/python'} 22:07:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:07:22 INFO - Running setup.py (path:/tmp/pip-ZxUBWf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:07:22 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)) 22:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:07:22 INFO - Running setup.py (path:/tmp/pip-thLALg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:07:22 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)) 22:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:07:22 INFO - Running setup.py (path:/tmp/pip-wYwJYV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:07:22 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)) 22:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:07:22 INFO - Running setup.py (path:/tmp/pip-KoEo8a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:07:23 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)) 22:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:07:23 INFO - Running setup.py (path:/tmp/pip-wHdZip-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:07:23 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)) 22:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:07:23 INFO - Running setup.py (path:/tmp/pip-HSdncO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:07:23 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)) 22:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:07:23 INFO - Running setup.py (path:/tmp/pip-K5qtQk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:07:23 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)) 22:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:07:23 INFO - Running setup.py (path:/tmp/pip-4an18e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:07:23 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)) 22:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:07:23 INFO - Running setup.py (path:/tmp/pip-zk7YoY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:07:23 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)) 22:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:07:23 INFO - Running setup.py (path:/tmp/pip-Czgd59-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:07:23 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)) 22:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:07:23 INFO - Running setup.py (path:/tmp/pip-4QFesj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:07:23 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)) 22:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:07:23 INFO - Running setup.py (path:/tmp/pip-0VUpDM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:07:23 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)) 22:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:07:23 INFO - Running setup.py (path:/tmp/pip-VvH5MU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:07:23 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)) 22:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:07:23 INFO - Running setup.py (path:/tmp/pip-Zu2LWN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:07:23 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)) 22:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:07:23 INFO - Running setup.py (path:/tmp/pip-VMyomO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:07:23 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)) 22:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:07:23 INFO - Running setup.py (path:/tmp/pip-fS88c1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:07:23 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)) 22:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:07:23 INFO - Running setup.py (path:/tmp/pip-xdB2dS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:07:23 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)) 22:07:23 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)) 22:07:23 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)) 22:07:23 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)) 22:07:23 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)) 22:07:24 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)) 22:07:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:07:24 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 22:07:24 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 22:07:24 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 22:07:24 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 22:07:24 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 22:07:24 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 22:07:25 INFO - Downloading blessings-1.5.1.tar.gz 22:07:25 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 22:07:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:07:25 INFO - Installing collected packages: blessings 22:07:25 INFO - Running setup.py install for blessings 22:07:25 INFO - Successfully installed blessings 22:07:25 INFO - Cleaning up... 22:07:25 INFO - Return code: 0 22:07:25 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:07:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:07:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:07:26 INFO - Reading from file tmpfile_stdout 22:07:26 INFO - Current package versions: 22:07:26 INFO - argparse == 1.2.1 22:07:26 INFO - blessings == 1.5.1 22:07:26 INFO - blobuploader == 1.2.4 22:07:26 INFO - docopt == 0.6.1 22:07:26 INFO - manifestparser == 1.1 22:07:26 INFO - mozInstall == 1.12 22:07:26 INFO - mozcrash == 0.16 22:07:26 INFO - mozdebug == 0.1 22:07:26 INFO - mozdevice == 0.47 22:07:26 INFO - mozfile == 1.2 22:07:26 INFO - mozhttpd == 0.7 22:07:26 INFO - mozinfo == 0.9 22:07:26 INFO - mozleak == 0.1 22:07:26 INFO - mozlog == 3.0 22:07:26 INFO - moznetwork == 0.27 22:07:26 INFO - mozprocess == 0.22 22:07:26 INFO - mozprofile == 0.27 22:07:26 INFO - mozrunner == 6.11 22:07:26 INFO - mozscreenshot == 0.1 22:07:26 INFO - mozsystemmonitor == 0.0 22:07:26 INFO - moztest == 0.7 22:07:26 INFO - mozversion == 1.4 22:07:26 INFO - psutil == 3.1.1 22:07:26 INFO - requests == 1.2.3 22:07:26 INFO - wsgiref == 0.1.2 22:07:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:07: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')]} 22:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07: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')]} 22:07:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07: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/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 0x7f0dcd830c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23636c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24246e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245aa90>, '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 0x24acf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ad2e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1447394334.150226-603385331', '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 22:07: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/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 22:07: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/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 22:07:26 INFO - Using env: {'DISPLAY': ':0', 22:07:26 INFO - 'HOME': '/home/cltbld', 22:07:26 INFO - 'LANG': 'en_US.UTF-8', 22:07:26 INFO - 'LANGUAGE': 'en_US:en', 22:07:26 INFO - 'LOGNAME': 'cltbld', 22:07:26 INFO - 'MAIL': '/var/mail/cltbld', 22:07:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:26 INFO - 'MOZ_NO_REMOTE': '1', 22:07:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:26 INFO - 'NO_EM_RESTART': '1', 22:07:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:26 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:26 INFO - 'SHELL': '/bin/bash', 22:07:26 INFO - 'SHLVL': '1', 22:07:26 INFO - 'TERM': 'linux', 22:07:26 INFO - 'TMOUT': '86400', 22:07:26 INFO - 'USER': 'cltbld', 22:07:26 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447394334.150226-603385331', 22:07:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:26 INFO - '_': '/tools/buildbot/bin/python'} 22:07:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:26 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)) 22:07:26 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)) 22:07:26 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)) 22:07:26 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)) 22:07:26 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)) 22:07:26 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)) 22:07:26 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)) 22:07:26 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)) 22:07:26 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)) 22:07:26 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)) 22:07:26 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)) 22:07:26 INFO - Cleaning up... 22:07:26 INFO - Return code: 0 22:07:26 INFO - Running post-action listener: _resource_record_post_action 22:07:26 INFO - Running post-action listener: _start_resource_monitoring 22:07:26 INFO - Starting resource monitoring. 22:07:26 INFO - ##### 22:07:26 INFO - ##### Running install step. 22:07:26 INFO - ##### 22:07:26 INFO - Running pre-action listener: _resource_record_pre_action 22:07:26 INFO - Running main action method: install 22:07:26 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:07:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:07:26 INFO - Reading from file tmpfile_stdout 22:07:26 INFO - Detecting whether we're running mozinstall >=1.0... 22:07:26 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:07:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:07:26 INFO - Reading from file tmpfile_stdout 22:07:26 INFO - Output received: 22:07:26 INFO - Usage: mozinstall [options] installer 22:07:26 INFO - Options: 22:07:26 INFO - -h, --help show this help message and exit 22:07:26 INFO - -d DEST, --destination=DEST 22:07:26 INFO - Directory to install application into. [default: 22:07:26 INFO - "/builds/slave/test-pgo"] 22:07:26 INFO - --app=APP Application being installed. [default: firefox] 22:07:26 INFO - mkdir: /builds/slave/test-pgo/build/application 22:07:26 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'] 22:07:26 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 22:07:41 INFO - Reading from file tmpfile_stdout 22:07:41 INFO - Output received: 22:07:41 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:07:41 INFO - Running post-action listener: _resource_record_post_action 22:07:41 INFO - ##### 22:07:41 INFO - ##### Running run-tests step. 22:07:41 INFO - ##### 22:07:41 INFO - Running pre-action listener: _resource_record_pre_action 22:07:41 INFO - Running main action method: run_tests 22:07:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:07:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:07:41 INFO - Python 2.7.3 22:07:41 INFO - Return code: 0 22:07:41 INFO - grabbing minidump binary from tooltool 22:07:41 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')]} 22:07:41 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 0x245aa90>, '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 0x24acf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ad2e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:07:41 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 22:07:41 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 22:07:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:07:41 INFO - Return code: 0 22:07:41 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:07:41 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:07:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:07:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:07:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:07:41 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/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 22:07:41 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/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost 22:07:41 INFO - Using env: {'DISPLAY': ':0', 22:07:41 INFO - 'HOME': '/home/cltbld', 22:07:41 INFO - 'LANG': 'en_US.UTF-8', 22:07:41 INFO - 'LANGUAGE': 'en_US:en', 22:07:41 INFO - 'LOGNAME': 'cltbld', 22:07:41 INFO - 'MAIL': '/var/mail/cltbld', 22:07:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:07:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:41 INFO - 'MOZ_NO_REMOTE': '1', 22:07:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:07:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:41 INFO - 'NO_EM_RESTART': '1', 22:07:41 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:41 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:41 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:07:41 INFO - 'SHELL': '/bin/bash', 22:07:41 INFO - 'SHLVL': '1', 22:07:41 INFO - 'TERM': 'linux', 22:07:41 INFO - 'TMOUT': '86400', 22:07:41 INFO - 'USER': 'cltbld', 22:07:41 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447394334.150226-603385331', 22:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:41 INFO - '_': '/tools/buildbot/bin/python'} 22:07:41 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/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost'] with output_timeout 3600 22:07:41 INFO - mozversion INFO | application_buildid: 20151112203045 22:07:41 INFO - mozversion INFO | application_changeset: 4b2ec935bc99bc505776190210b11dfe552bd041 22:07:41 INFO - mozversion INFO | application_display_name: Nightly 22:07:41 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:07:41 INFO - mozversion INFO | application_name: Firefox 22:07:41 INFO - mozversion INFO | application_remotingname: firefox 22:07:41 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 22:07:41 INFO - mozversion INFO | application_vendor: Mozilla 22:07:41 INFO - mozversion INFO | application_version: 45.0a1 22:07:41 INFO - mozversion INFO | platform_buildid: 20151112203045 22:07:41 INFO - mozversion INFO | platform_changeset: 4b2ec935bc99bc505776190210b11dfe552bd041 22:07:41 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 22:07:41 INFO - mozversion INFO | platform_version: 45.0a1 22:07:41 INFO - 2015-11-12 22:07:41,397 DEBUG : using testdate: 1447394861 22:07:41 INFO - 2015-11-12 22:07:41,397 DEBUG : actual date: 1447394861 22:07:41 INFO - 2015-11-12 22:07:41,404 INFO : starting webserver on 'localhost:57722' 22:07:41 INFO - 2015-11-12 22:07:41,405 INFO : Starting test suite talos-linux64-ix-068 22:07:41 INFO - 2015-11-12 22:07:41,405 INFO : Starting test dromaeo_css 22:07:41 INFO - 2015-11-12 22:07:41,405 DEBUG : operating with platform_type : linux_ 22:07:41 INFO - 2015-11-12 22:07:41,405 INFO : Initialising browser for dromaeo_css test... 22:07:41 INFO - 2015-11-12 22:07:41,427 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpE55eX0/profile http://localhost:57722/getInfo.html 22:07:48 INFO - 2015-11-12 22:07:48,068 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:07:48 INFO - 2015-11-12 22:07:48,068 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:07:48 INFO - 2015-11-12 22:07:48,068 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:07:48 INFO - 2015-11-12 22:07:48,068 DEBUG : BROWSER_OUTPUT: __metrics 22:07:48 INFO - 2015-11-12 22:07:48,225 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:07:49 INFO - 2015-11-12 22:07:49,348 INFO : Browser initialized. 22:07:49 INFO - 2015-11-12 22:07:49,348 INFO : Running cycle 1/1 for dromaeo_css test... 22:07:49 INFO - 2015-11-12 22:07:49,349 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpE55eX0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:08:01 INFO - 2015-11-12 22:08:01,136 DEBUG : BROWSER_OUTPUT: RSS: Main: 140832768 22:08:01 INFO - 2015-11-12 22:08:01,137 DEBUG : BROWSER_OUTPUT: 22:08:52 INFO - 2015-11-12 22:08:52,777 DEBUG : BROWSER_OUTPUT: 1447394932773 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] 22:11:01 INFO - 2015-11-12 22:11:01,333 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57722/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57722/tests/dromaeo/cssquery-ext.html) 22:11:02 INFO - 2015-11-12 22:11:02,370 DEBUG : BROWSER_OUTPUT: RSS: Main: 229593088 22:11:02 INFO - 2015-11-12 22:11:02,370 DEBUG : BROWSER_OUTPUT: 22:14:04 INFO - 2015-11-12 22:14:04,792 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57722/tests/dromaeo/cssquery-ext.html (next: http://localhost:57722/tests/dromaeo/cssquery-jquery.html) 22:14:05 INFO - 2015-11-12 22:14:05,358 DEBUG : BROWSER_OUTPUT: RSS: Main: 224083968 22:14:05 INFO - 2015-11-12 22:14:05,358 DEBUG : BROWSER_OUTPUT: 22:17:07 INFO - 2015-11-12 22:17:07,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57722/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57722/tests/dromaeo/cssquery-mootools.html) 22:17:07 INFO - 2015-11-12 22:17:07,928 DEBUG : BROWSER_OUTPUT: RSS: Main: 210862080 22:17:07 INFO - 2015-11-12 22:17:07,928 DEBUG : BROWSER_OUTPUT: 22:20:09 INFO - 2015-11-12 22:20:09,763 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57722/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57722/tests/dromaeo/cssquery-prototype.html) 22:20:10 INFO - 2015-11-12 22:20:10,324 DEBUG : BROWSER_OUTPUT: RSS: Main: 201445376 22:20:10 INFO - 2015-11-12 22:20:10,324 DEBUG : BROWSER_OUTPUT: 22:23:12 INFO - 2015-11-12 22:23:12,778 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57722/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57722/tests/dromaeo/cssquery-yui.html) 22:23:13 INFO - 2015-11-12 22:23:13,345 DEBUG : BROWSER_OUTPUT: RSS: Main: 207073280 22:23:13 INFO - 2015-11-12 22:23:13,345 DEBUG : BROWSER_OUTPUT: 22:26:15 INFO - 2015-11-12 22:26:15,944 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57722/tests/dromaeo/cssquery-yui.html (next: http://localhost:57722/tests/dromaeo/cssquery-dojo.html) 22:26:16 INFO - 2015-11-12 22:26:16,202 DEBUG : BROWSER_OUTPUT: RSS: Main: 265596928 22:26:16 INFO - 2015-11-12 22:26:16,202 DEBUG : BROWSER_OUTPUT: 22:26:16 INFO - 2015-11-12 22:26:16,203 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:26:16 INFO - 2015-11-12 22:26:16,203 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:26:16 INFO - 2015-11-12 22:26:16,203 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:26:16 INFO - 2015-11-12 22:26:16,203 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:26:16 INFO - 2015-11-12 22:26:16,203 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3128.7653425993053;3270.411325961326;3302.8018318900868;3304.1078908694653;3310.271740217152;5159.097157997354;5298;5440.673559586423;5452.400235974044;5461.235427040213;5304.867378315544;5353.625246232756;5358.062339090663;5365.168398898168;5467.753951072202;4936.111499930011;4936.7778449969655;5018.849434516952;5060.418051924021;5137.691738495702;5033.471485494026;5054.444011158769;5118.820841270556;5131.127708289581;5202.739863006854;4825.710457372551;4915.754212289407;4916.58209052231;5020;5040.999999999964;5006.249062640597;5013.899722005576;5023.673461225045;5026.623003274769;5056.519630635084;4826.638002149818;4983.775730092155;4985;5017.523335283142;5059.620528460343;5113.51421614946;5167.147420675584;5186.896262074737;5203.531682148587;5214.426413094557;5824.126381042835;5824.417558244184;5827.155062515912;5838.241028666289;5857.853553661193;5488.341399032141;5585.050541407971;5874.588778785486;5883.14694369314;5886.146508756249;5446.210299506589;5505.421930697299;5510.201020851954;5517.944820551783;5567.053600887859;5924.437178468039;5930.9406905931255;5933.228680271537;5940.108983652401;5946.286445626552;5545.916811247835;5686.260786097863;5752.511036561939;5775.5668324875805;5783.624064435799;5866.911996320058;5872.148538461899;5876.324222714357;5894.764209431661;5935.2877654681715;5839.416058394211;5843.415658434207;5849.239598852122;5850.210221620112;5852.180694702745;5709.74306156224;5755.251817263729;5801.332846722681;5864.677442740605;5869.413058694182;4486.618637415856;4500.887477813081;4517.435320584927;4527.637788976874;4566.680332376702;3995.6403923647013;4009.258287216874;4024.7987600620436;4041.1513582148077;4047.7166598337835;5259.894802103937;5274.077036518671;5448.346198456132;5450.209719590637;5471.124620060771;5857.7656893724625;5881.823545293562;5886.440788125121;5893.734781934823;5896.3219229788265;5501.504864562208;5508.256385388001;5522.144067669517;5530.142827861688;5532;4936.75316234194;5026.824061157842;5054.7472626368535;5113.181890897438;5165.586753059746;6189.6286222826775;6208.627482351073;6209.844753881189;6214.658193799294;6220.346863579259;5756.2229099072765;5945.64326140433;5965.612235204698;5974.581779275409;5983;6024.9397506026135;6070.7392945915835;6101.359357267423;6116.755329786759;6118.284172697687;5734.54123670097;5736.082226843685;5739.225204597493;5747.453991870766;5825.2135961644635;5675.631083979528;5811.76752929895;5823.854403639943;5828.650280982985;5833.183354330312;5589.664620122806;5646.520045795989;5654.575906807088;5669.007923613433;5721.284839395075;5748.913766293593;5780.161876527795;5784.479396854135;5791.47876691083;5801.738921748447;5412.78348866041;5532.0595498766115;5688.687122208318;5689.032864413142;5689.34572524165;5696.231008813757;5700.515456186271;5790.913136302875;5818.709064546841;5864.67744274069;5674.517665998436;5675.716214189357;5677.716114194356;5686.147077938343;5733.569982251264 22:26:16 INFO - 2015-11-12 22:26:16,204 DEBUG : BROWSER_OUTPUT: |1;ext.html;577.7284676202186;584.9327327357353;596.1028651878922;603.5292471871942;605.071215683925;31302.843485782567;32198.839005804966;39985.60014399855;40461.59538404615;40513.189736205255;42057.579424205745;42634.7868260659;42846;43046.13907721844;43063.35404968928;8515.361347898901;8685.522296273703;8696.521691306976;8699;8782.736517904474;7687.0391201099865;7858.607069646523;10475.109615682675;10690.144788416908;10704.78590428191;10312;10418.062374386303;10431.426271555061;10432.895671043307;10433.16534677224;7654.732084377076;7844.294013538809;10335;10464.895351046544;10466.581336746522;10449.895501044968;10613.787724245549;10635.776885658172;10668.733281667943;10676.786464270748;38906.22187556233;39280.41079383811;39321;39374.60625393738;39376.80311598453;3031.5452682097643;3082.291073053188;3114.9221269468444;3184.9363012739846;3605.314990151889;30355.848220758755;30483;30730.385392292254;30746.846265768527;31487.685123148705;3351.949720754191;3353.295807880348;3354.647761985005;3385.0691059958463;3461.5326930864517;273052;274046;274212;274321;274519;53462.465375345746;54454.18318725222;55284.617884552405;57653.135202971986;58563.70718146382;54314.45685543173;54415.18377224345;54615.18077228845;54656.18015729767;54702;13702.588922332347;13821.79267310991;13985.510507132201;14079.648008799657;14103.647408814863;10177.643782467578;10249.538770755185;10260.486975651187;10287.177025837915;10314.896851031393;18420.723689144674;18607.53481162982;18724.906375468036;18806.623867522572;18830.24679012824;7152.463565232629;7425.888611670829;7475.803871380553;7523.849523009619;7544.283293087148;941.4539567051231;947.8578213267928;1005.4369553050316;1011.9241056920761;1034.8395998620226;28431.147065588066;28476.572851407247;28596;28918.132456026353;29001.419971600873;975.6926568131016;991.9057689519484;1050.6690392526482;1066.0618655583037;1097.1771171621283;13315.733685326433;13369.866301337057;13509.59471215865;13549.119307244997;13662.931685341708;318364;318761;321141;321769;321993;48623.27065094026;48850.75574622175;48871.5112848867;48951.51048489541;49002;1315.6447759104988;1319.957233785318;1329.4881470633875;1342.8455727591256;1344.1464669934467;22042.559148817254;27592;27661.723382765915;28242.43515129645;28358;43216.35175472433;43225;43585.34621980736;43684.781576093184;43691;263600.63993601257;264551;265211;267624;267899;27131.59302610502;27652.861735691193;30262;30607.387852243275;31484.212894677818;37769.244615106996;37941;37998.810005949796;38028.809855950545;38763.2247355057;32522.34955300928;33592.49611255882;34328.31343373169;34837.47743783896;35699.64300356963;28184.65153793332;32967.34065318728;33921.49117763186;34917.30165396729;35589;32093.197670058435;32461.350772983937;32697.18257043593;32796.34407311793;32834.343313133126;28896.844126235555;31007;31380.843095784374;31618.841905791243;31671.683283166873;23255.3023409298;23421.180258690863;23669.934852931314;23927.401814954766;24023.27930162098 22:26:16 INFO - 2015-11-12 22:26:16,204 DEBUG : BROWSER_OUTPUT: |2;jquery.html;310.9639390077691;313.7772181750957;321.8471226167571;334.12792611284544;337.7821305258109;10258.07677309042;10648.680539583826;12069.275843449388;16633.750493742602;17224.827751722496;16914.66170676586;17014.40449584265;17017.2342244599;17179.141042947835;17256.223469943852;5716.542676585863;6000.969995150018;6003.879922401549;6004.939950600504;6008.759649614032;4189.706720529564;4266;5943.286805583336;6595.967020164892;6854.143232095988;6625.60246385216;6774.5257831951785;6775.1531058617675;6819.420349270318;6833.726650933957;6918.827029324282;6959.269276725972;6969.546979446345;6972.825679358006;6976.093107895967;6156.538259630545;6371.23545174582;6377.7767778127545;6659.9001014984815;6672.299408562079;21408;23202;23480.76519234803;23563.646545301835;23594.528109437888;1946.3285166617495;1955.071341112974;1991.7410736604293;2082.6355387807075;2162.589108069462;13478.865211347858;13644.727105457934;13964.511242106579;14101.64745881351;14120.903553958866;1831.5878927241397;1890.3100368365585;1914.1290712725815;1926.6339395514808;1939.3697048459308;66900;68036.6598167006;68682.31317686859;68975.65512172457;70206.29793702048;14658.267086645625;15015.399384024735;15337.309821057856;15438.150901700514;15480.767788483181;23978.640320395207;24016.759832401804;24217.304788664977;24248.393790155387;24254.151104711604;8491.915080849236;8543.743687689379;8600.440971336842;8615.913840861636;8665.523396213268;7259.092613423322;7279.818004549823;7316.890246646304;7320.450966177558;7340.559566426032;6515.250746164157;7504.887426688604;7589.506682065648;7702.422318326148;7757.379409647215;2703.891844326205;2979.6275465566805;2980.8211507309197;3025.6823033581595;3065.11111777582;409.0673264955905;424.7727465805779;430.9956900430956;436.46315032509557;450.79263538772534;10620.415877126832;11843.407829608657;11860.881391185978;12000.639980800415;12085.45615447307;439.79329715033884;444.02314907204277;449.4718705521;452.7351499372838;454.8771831605448;6261.186045814015;6483.3192514786215;6500;6514.934850651528;6648.235452922879;477740;490325;540633;542428;542526;66875;67533;68816;71200;76224.61887690525;485.54843995084207;491.63127654259307;495.09891996566625;495.34366963773147;495.9107360675113;10656.89343106559;10926.50830712604;11333.603323883624;11405.429728513707;11480.311181329147;31828.36343273168;32244.677553224166;32771.99999999905;35217.64782352144;35233;43377.783111084245;45541.31688024748;47018.29472557846;47506.28740568825;52182.739086304326;14451.566453006426;14472.927635361755;15054.623634409227;15175.620609484851;15188.392464301303;18617.81382186215;18854.3400980965;18875.811241887954;19409;19784.505387365432;15503;15578.766318505004;15722.685546288782;15801.920990394974;16048.19759012068;8566.957165214135;8729.170728780755;14867.92566037163;15556.533304000897;15646.139462329225;8715.694950676696;8846.336524760798;8913.197812196933;8989.775255618662;8993.640254389751;13957.255343082115;14333;14405.9279703605;14620.195889226196;14633.122012679274;8513.95743021281;8841.204291613785;8997.055309192703;15555.922220388826;15600.375984960474 22:26:16 INFO - 2015-11-12 22:26:16,207 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1354.3566805767268;1678.1022153148067;1696.8303169683034;1743.1284357821094;1751.5708651380414;6152.938470615298;6708.832279193022;6852.7944161675105;6854.177498700163;6869.278725733801;6803.829904252384;6934.063901373325;6945;6949.722011119549;6954.0959675242275;1878.614883948787;1904.8190421909896;2093.0685844799073;2147.860389074713;2167.8482506224573;2123.8407119466024;2132.1471411435396;2134.0930104705517;2139.21918499748;2178.357384571555;2119.290037837319;2196.9121235150574;2209.1936443198197;2209.414505156135;2217.4456385903522;1935.4097000414868;1973.3487948976804;2095.31902131807;2141.1649456711893;2141.3040761752336;2156.2453141400542;2159.546495236002;2198.1756841184556;2198.769129241439;2202.3282898715884;6870.725170993154;6935.306469353075;6942.72229110835;6969.930300697029;6973.442124630017;4161.729487583328;4235.089455767024;4256.063665993476;4260.510041345223;4262.850800222009;2752.3118424065046;2807.03157410693;2808.9719102808913;2840.9857950710116;2858.1139846647397;844.6452489954172;851.7402192331336;864.0797550608645;888.7244954064196;889.8754174415587;9633;9694.854577181277;9702.320837541374;9705.272104592184;9721.222302215876;3791.829367678461;3845.384738441836;3871.9612803872164;3895.590962948906;3920.9215815684097;8092.676292948334;8131.715389961323;8140.063892652421;8150;8156.939597852242;4201.264778663722;4221.366794980716;4223.852165174204;4228.4080228768;4229.154169166179;3903;3926.646601805794;3932.4297976793778;3957.2679054375035;3957.406389041609;3382.5602671652528;3408.931821363559;3412.7269818414466;3413.2832105257676;3431.605365382963;1145.5646854195352;1149.1209224942925;1171.7305019845483;1172.806486929647;1176.529388244709;871.899731530882;1205.1925210109248;1208.546794951893;1209.7520008398258;1231.655136561764;5770.480656740913;6491.156149700509;6724.327567243236;6726.495512836459;6735.865282694319;666.1939053745023;667.8263651450561;680.5406350713249;693.1785833786979;694.7429451103023;4707.576318131385;4716.151092803259;4733.644976626767;4743.810247590127;4745.383100197021;8150;8193.631286592117;8341.708040218564;8348.415610907177;8348.499090054616;8329.66681332752;8498.362622803315;8529.957350213333;8578.485290882567;8582.442141260799;6702.832429189211;6722.731090756315;6722.764703235461;6752.5273230874345;6769.526133170729;5853.970730146322;5918.911216331672;5957.076653118774;5997.580169388101;5999.730012149551;7462.291082347168;7531.284527969834;7546.698132074655;7594.8101297468;7633.465657403928;7597.810054748676;7773.805654858674;7793.454458187873;7803.336716379172;7939.841203175789;6209.037599172136;6243.282022567463;6246.437820596168;6254.874902501833;6259.78090766821;6787.796366109024;6846.863062738817;6848.3494068063455;6868.553544019623;6899.931000689929;6463.450606698295;6505.804825855232;6527.281998980014;6536.0522724205675;6546.639934803631;6255.499560035278;6384.3934826191435;6386.680665966776;6494.935050649433;6504.707288171949;6036.637801731735;6120.418560236771;6167.321594624677;6170.475509581735;6173.475254603409;5737.139429085671;5754.194412782297;5756.740946657326;5759.136129580429;5762.279715035621;5675.886482270249;5711.200431939615;5755.107958266475;5764.625299355528;5778.913316300343 22:26:16 INFO - 2015-11-12 22:26:16,207 DEBUG : BROWSER_OUTPUT: |4;prototype.html;281.39500074839094;283.8864454218313;284.37863268757764;285.1516737705328;290.474241622663;5862.648241105537;5973.313068997067;6002.399760023995;6033.577649564532;6043.939560604398;5777.7977770777925;5917.585768996172;5937.821865344035;5944.256967879015;5961.344252132262;4434.645228381738;4438.755868427235;4446.822127114928;4467.7542735149555;4471.195184866723;4262.616364527192;4350.303951367781;4366.868993930171;4426.667999900004;4471.105778844228;4429.092036132585;4429.667774916878;4434.756088415136;4435.467743870724;4457.242268814293;4423.049044455457;4427.446569178853;4431.534688857688;4435.334699795024;4438.755868427235;3823.674987626055;3827.540695116576;3827.789471579062;3832.885013449601;3837.539495260559;5506.834794956158;5611.438856114397;5627.099664053772;5641.2384328116;5648.717564121777;5132.358455193101;5141.820036298712;5144.897102057976;5148.84553463393;5148.922766158511;6232.594881332699;6246.6876656167005;6251.906221406683;6260.060990851363;6268.216472940882;3985.8405663773415;4096.959030409717;4135.028268356934;4207.663386929069;4221.2190744712325;6562.573432726857;6578.63817490033;6580.24327202373;6583.177102862142;6608.801735947881;4299.1831552005015;4300.935485967713;4311.8706438806885;4312.849050283225;4317.050248945227;4233.682473814476;4346.043870348518;4351.3255445405375;4357.779821649943;4359.324304732771;5111.386633603917;5118.25785261135;5119.539241468286;5119.923201151985;5130.256112863689;6395.52033597482;6400.9039864402075;6404.48764098871;6410.711517981702;6414.903776443264;1533.279358701431;1551.1623723189352;1551.6663917257845;1554.35494269879;1557.0891028748308;1007.8286691262502;1025.4923812712755;1026.0611540440564;1027.2603725317758;1033.8035773203067;6174.073888916699;6194.38056194377;6196.946519091765;6214.937850621436;6222.62664240147;6601.8349541260895;6602.372774586406;6605.273419923805;6607;6629.469642428594;6068.362821903725;6197.03945888388;6199.163112979781;6202.751889924442;6214.378562143749;3561.465780133001;3599.6040435552068;3609.151849315409;3610.9277814443562;3611.3499570077115;6866.896996545056;6901.275366086589;6908.620025898624;6914.239433662293;6933.2720064392515;6638.966805165944;6760.966195168992;6762.594244345355;6769.289224631441;6775.186977562724;6884.965575172192;6902.723891044302;6902.8619427612175;6907.067545881242;6908.5509441886115;6580.76967306142;6582.76960306387;6585.901211481927;6588.769393071411;6591.549859031005;6290.150829637941;6467.256265529524;6494.577852439576;6614.933850661432;6616.2391324996315;6959.930400695928;6966.164060312795;6976.267491913276;6987.266337034538;6995.335443132894;4355.49911760139;4359.128174365076;4359.738415695068;4361.12777444506;4362.345648152803;6527.5430719849155;6633.104530888461;6654.367835055662;6661.633610151488;6670.39966403026;6324.683765811783;6353.809385718436;6443.484521238383;6474.546781725422;6480.611163330215;6297.960836462115;6308.558400911892;6324.715387807468;6326.841828954313;6332.145160403471;6049.758009679564;6190.969045154746;6220.284667263322;6223.097650840512;6233.75064997395;6356.618602883842;6363.172787537591;6368.936310636835;6369.01280301554;6374.968125159345;6116.877662446637;6207.782727604512;6209.844753881189;6229.972054611119;6247.5939063960695 22:26:16 INFO - 2015-11-12 22:26:16,209 DEBUG : BROWSER_OUTPUT: |5;yui.html;668.3283300283215;694.7464175575915;816.4896939412866;834.0899340510229;870.142909234404;13082.73834523309;13208;13274.137181083222;13299.202047877134;13308.933455332734;12441.37793110343;12583.874161258385;12668.936655316733;12674.809877851816;12720.045996550249;665.1486097794806;822.6421506644614;834.4034015678789;834.5535138700797;834.5618550261131;670.0518765946181;810.8256724804166;823.9258466737992;827.4952279109739;831.2020460358063;846.3525403066659;863.5078005536847;863.926566241867;868.3791089371099;869.7477731457869;688.3942130924804;693.1958927643909;845.121074082953;845.3026253340987;851.9318454523655;621.9720112594944;628.2617923939353;629.0093103362223;629.0469938043867;631.7188850961325;12852.935735321356;12874;12975.286359250238;13040.217586944718;13040.413181406859;11434.656960291204;12081.395930203455;12377.62867113988;12457.1902826316;12705.555305564261;9768.267379946532;9808.509574521246;9813.607455701764;9917.90082099177;9953.75115622108;3559.5906470755676;3650.908727281813;3671.1372827385812;3689;3700.7409481336317;46380.3042954356;46567.534324657;46741;46783;47783.283250751614;9358.672446464341;9791.804163916682;10035.648752293635;10135.189184865194;10148.695539133838;18514.16686249122;18544.907275463538;18618.44144675662;18650.626987460175;18676.626467470847;7212.7114915403845;7236.963815180996;7273.818154546073;7323.121225452873;7422.591757453392;4022.738521996061;4127.484064491939;4163.8959026024595;4168.651266174507;4183.351580504966;2706.066407089551;2759.227416323433;2965.2883308006353;2984.9552256716165;2993.7904346695523;464.3615029334665;471.6839717389357;477.1340017867559;479.72655586316165;479.95920346770913;540.7863893761942;623.4918541388754;633.6419922743635;635.4693830651457;637.9330170332141;7510.6620202091035;7516.549007059594;7749.651265693057;8264.380171487042;9236.491992940453;565.9632123911932;653.4772182254178;656.714329266761;673.1806797144891;716.6416791604198;3822.2164456286396;3843.3082045231567;3863.439801228806;3990.9002274942777;4218.620324170839;52979.735101324244;53177.46822531725;53355.73322133442;54297;55003;48085;48204.5179548207;48385.27422088671;48800.755996220505;49974;43633;43911.121777564906;44269.33595996063;45447.77276113598;45709.77145114253;7726.613669316399;8168;8359.832803344021;8436.74667485079;8509.74470765878;33444.83277583597;33794.15514612154;34492.65507344894;34564.65435345614;34920.82539587286;42209.788951055045;42726.35910461408;42850.57149428466;42922.78538607287;43021.784891075346;6903.1371078615175;6948.583085014915;7108.537945033556;7175.03137076488;7213.134423869169;10686.893639062071;10811.6215932442;10929.836052459379;11282.7743445129;11624.767504650028;10680.412577308323;10781.676549703521;10902.291351062155;11017.724556886142;11212.43937803123;10719;11164.441777911234;11190.83213751778;11211.55153793839;11599;10047.447390393598;10827.13382929348;10906;11078.05836503874;11214.327140371604;9265.768355791159;9471.47906865129;9519.57161927701;9566;9592.376495527767;8425.578721064045;8589.14108589136;9204.217641500547;9279.164875161268;9389.718308450758 22:26:16 INFO - 2015-11-12 22:26:16,209 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:26:16 INFO - 2015-11-12 22:26:16,209 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:26:16 INFO - 2015-11-12 22:26:16,209 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,789 22:26:16 INFO - 2015-11-12 22:26:16,209 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:26:16 INFO - 2015-11-12 22:26:16,209 DEBUG : BROWSER_OUTPUT: __startTimestamp1447395976196__endTimestamp 22:26:16 INFO - 2015-11-12 22:26:16,209 DEBUG : BROWSER_OUTPUT: 22:26:16 INFO - 2015-11-12 22:26:16,209 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:26:16 INFO - 2015-11-12 22:26:16,209 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:26:16 INFO - 2015-11-12 22:26:16,209 DEBUG : BROWSER_OUTPUT: 22:26:16 INFO - 2015-11-12 22:26:16,210 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5429.39 Median:5654.58 stddev:604.32 (10.7%) stddev-sans-first:578.60 22:26:16 INFO - 2015-11-12 22:26:16,210 DEBUG : BROWSER_OUTPUT: Values: 3128.8 3270.4 3302.8 3304.1 3310.3 5159.1 5298.0 5440.7 5452.4 5461.2 5304.9 5353.6 5358.1 5365.2 5467.8 4936.1 4936.8 5018.8 5060.4 5137.7 5033.5 5054.4 5118.8 5131.1 5202.7 4825.7 4915.8 4916.6 5020.0 5041.0 5006.2 5013.9 5023.7 5026.6 5056.5 4826.6 4983.8 4985.0 5017.5 5059.6 5113.5 5167.1 5186.9 5203.5 5214.4 5824.1 5824.4 5827.2 5838.2 5857.9 5488.3 5585.1 5874.6 5883.1 5886.1 5446.2 5505.4 5510.2 5517.9 5567.1 5924.4 5930.9 5933.2 5940.1 5946.3 5545.9 5686.3 5752.5 5775.6 5783.6 5866.9 5872.1 5876.3 5894.8 5935.3 5839.4 5843.4 5849.2 5850.2 5852.2 5709.7 5755.3 5801.3 5864.7 5869.4 4486.6 4500.9 4517.4 4527.6 4566.7 3995.6 4009.3 4024.8 4041.2 4047.7 5259.9 5274.1 5448.3 5450.2 5471.1 5857.8 5881.8 5886.4 5893.7 5896.3 5501.5 5508.3 5522.1 5530.1 5532.0 4936.8 5026.8 5054.7 5113.2 5165.6 6189.6 6208.6 6209.8 6214.7 6220.3 5756.2 5945.6 5965.6 5974.6 5983.0 6024.9 6070.7 6101.4 6116.8 6118.3 5734.5 5736.1 5739.2 5747.5 5825.2 5675.6 5811.8 5823.9 5828.7 5833.2 5589.7 5646.5 5654.6 5669.0 5721.3 5748.9 5780.2 5784.5 5791.5 5801.7 5412.8 5532.1 5688.7 5689.0 5689.3 5696.2 5700.5 5790.9 5818.7 5864.7 5674.5 5675.7 5677.7 5686.1 5733.6 22:26:16 INFO - 2015-11-12 22:26:16,210 DEBUG : BROWSER_OUTPUT: 22:26:16 INFO - 2015-11-12 22:26:16,210 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44802.98 Median:31645.26 stddev:75173.94 (237.6%) stddev-sans-first:75311.49 22:26:16 INFO - 2015-11-12 22:26:16,210 DEBUG : BROWSER_OUTPUT: Values: 577.7 584.9 596.1 603.5 605.1 31302.8 32198.8 39985.6 40461.6 40513.2 42057.6 42634.8 42846.0 43046.1 43063.4 8515.4 8685.5 8696.5 8699.0 8782.7 7687.0 7858.6 10475.1 10690.1 10704.8 10312.0 10418.1 10431.4 10432.9 10433.2 7654.7 7844.3 10335.0 10464.9 10466.6 10449.9 10613.8 10635.8 10668.7 10676.8 38906.2 39280.4 39321.0 39374.6 39376.8 3031.5 3082.3 3114.9 3184.9 3605.3 30355.8 30483.0 30730.4 30746.8 31487.7 3351.9 3353.3 3354.6 3385.1 3461.5 273052.0 274046.0 274212.0 274321.0 274519.0 53462.5 54454.2 55284.6 57653.1 58563.7 54314.5 54415.2 54615.2 54656.2 54702.0 13702.6 13821.8 13985.5 14079.6 14103.6 10177.6 10249.5 10260.5 10287.2 10314.9 18420.7 18607.5 18724.9 18806.6 18830.2 7152.5 7425.9 7475.8 7523.8 7544.3 941.5 947.9 1005.4 1011.9 1034.8 28431.1 28476.6 28596.0 28918.1 29001.4 975.7 991.9 1050.7 1066.1 1097.2 13315.7 13369.9 13509.6 13549.1 13662.9 318364.0 318761.0 321141.0 321769.0 321993.0 48623.3 48850.8 48871.5 48951.5 49002.0 1315.6 1320.0 1329.5 1342.8 1344.1 22042.6 27592.0 27661.7 28242.4 28358.0 43216.4 43225.0 43585.3 43684.8 43691.0 263600.6 264551.0 265211.0 267624.0 267899.0 27131.6 27652.9 30262.0 30607.4 31484.2 37769.2 37941.0 37998.8 38028.8 38763.2 32522.3 33592.5 34328.3 34837.5 35699.6 28184.7 32967.3 33921.5 34917.3 35589.0 32093.2 32461.4 32697.2 32796.3 32834.3 28896.8 31007.0 31380.8 31618.8 31671.7 23255.3 23421.2 23669.9 23927.4 24023.3 22:26:16 INFO - 2015-11-12 22:26:16,210 DEBUG : BROWSER_OUTPUT: 22:26:16 INFO - 2015-11-12 22:26:16,210 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28742.83 Median:2299.39 stddev:84776.97 (3686.9%) stddev-sans-first:84987.91 22:26:16 INFO - 2015-11-12 22:26:16,210 DEBUG : BROWSER_OUTPUT: Values: 311.0 313.8 321.8 334.1 337.8 10258.1 10648.7 12069.3 16633.8 17224.8 16914.7 17014.4 17017.2 17179.1 17256.2 5716.5 6001.0 6003.9 6004.9 6008.8 4189.7 4266.0 5943.3 6596.0 6854.1 6625.6 6774.5 6775.2 6819.4 6833.7 6918.8 6959.3 6969.5 6972.8 6976.1 6156.5 6371.2 6377.8 6659.9 6672.3 21408.0 23202.0 23480.8 23563.6 23594.5 1946.3 1955.1 1991.7 2082.6 2162.6 13478.9 13644.7 13964.5 14101.6 14120.9 1831.6 1890.3 1914.1 1926.6 1939.4 66900.0 68036.7 68682.3 68975.7 70206.3 14658.3 15015.4 15337.3 15438.2 15480.8 23978.6 24016.8 24217.3 24248.4 24254.2 8491.9 8543.7 8600.4 8615.9 8665.5 7259.1 7279.8 7316.9 7320.5 7340.6 6515.3 7504.9 7589.5 7702.4 7757.4 2703.9 2979.6 2980.8 3025.7 3065.1 409.1 424.8 431.0 436.5 450.8 10620.4 11843.4 11860.9 12000.6 12085.5 439.8 444.0 449.5 452.7 454.9 6261.2 6483.3 6500.0 6514.9 6648.2 477740.0 490325.0 540633.0 542428.0 542526.0 66875.0 67533.0 68816.0 71200.0 76224.6 485.5 491.6 495.1 495.3 495.9 10656.9 10926.5 11333.6 11405.4 11480.3 31828.4 32244.7 32772.0 35217.6 35233.0 43377.8 45541.3 47018.3 47506.3 52182.7 14451.6 14472.9 15054.6 15175.6 15188.4 18617.8 18854.3 18875.8 19409.0 19784.5 15503.0 15578.8 15722.7 15801.9 16048.2 8567.0 8729.2 14867.9 15556.5 15646.1 8715.7 8846.3 8913.2 8989.8 8993.6 13957.3 14333.0 14405.9 14620.2 14633.1 8514.0 8841.2 8997.1 15555.9 15600.4 22:26:16 INFO - 2015-11-12 22:26:16,211 DEBUG : BROWSER_OUTPUT: 22:26:16 INFO - 2015-11-12 22:26:16,211 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4905.95 Median:6078.53 stddev:2513.43 (41.3%) stddev-sans-first:2506.30 22:26:16 INFO - 2015-11-12 22:26:16,212 DEBUG : BROWSER_OUTPUT: Values: 1354.4 1678.1 1696.8 1743.1 1751.6 6152.9 6708.8 6852.8 6854.2 6869.3 6803.8 6934.1 6945.0 6949.7 6954.1 1878.6 1904.8 2093.1 2147.9 2167.8 2123.8 2132.1 2134.1 2139.2 2178.4 2119.3 2196.9 2209.2 2209.4 2217.4 1935.4 1973.3 2095.3 2141.2 2141.3 2156.2 2159.5 2198.2 2198.8 2202.3 6870.7 6935.3 6942.7 6969.9 6973.4 4161.7 4235.1 4256.1 4260.5 4262.9 2752.3 2807.0 2809.0 2841.0 2858.1 844.6 851.7 864.1 888.7 889.9 9633.0 9694.9 9702.3 9705.3 9721.2 3791.8 3845.4 3872.0 3895.6 3920.9 8092.7 8131.7 8140.1 8150.0 8156.9 4201.3 4221.4 4223.9 4228.4 4229.2 3903.0 3926.6 3932.4 3957.3 3957.4 3382.6 3408.9 3412.7 3413.3 3431.6 1145.6 1149.1 1171.7 1172.8 1176.5 871.9 1205.2 1208.5 1209.8 1231.7 5770.5 6491.2 6724.3 6726.5 6735.9 666.2 667.8 680.5 693.2 694.7 4707.6 4716.2 4733.6 4743.8 4745.4 8150.0 8193.6 8341.7 8348.4 8348.5 8329.7 8498.4 8530.0 8578.5 8582.4 6702.8 6722.7 6722.8 6752.5 6769.5 5854.0 5918.9 5957.1 5997.6 5999.7 7462.3 7531.3 7546.7 7594.8 7633.5 7597.8 7773.8 7793.5 7803.3 7939.8 6209.0 6243.3 6246.4 6254.9 6259.8 6787.8 6846.9 6848.3 6868.6 6899.9 6463.5 6505.8 6527.3 6536.1 6546.6 6255.5 6384.4 6386.7 6494.9 6504.7 6036.6 6120.4 6167.3 6170.5 6173.5 5737.1 5754.2 5756.7 5759.1 5762.3 5675.9 5711.2 5755.1 5764.6 5778.9 22:26:16 INFO - 2015-11-12 22:26:16,212 DEBUG : BROWSER_OUTPUT: 22:26:16 INFO - 2015-11-12 22:26:16,212 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5272.76 Median:6059.06 stddev:1652.77 (27.3%) stddev-sans-first:1614.39 22:26:16 INFO - 2015-11-12 22:26:16,212 DEBUG : BROWSER_OUTPUT: Values: 281.4 283.9 284.4 285.2 290.5 5862.6 5973.3 6002.4 6033.6 6043.9 5777.8 5917.6 5937.8 5944.3 5961.3 4434.6 4438.8 4446.8 4467.8 4471.2 4262.6 4350.3 4366.9 4426.7 4471.1 4429.1 4429.7 4434.8 4435.5 4457.2 4423.0 4427.4 4431.5 4435.3 4438.8 3823.7 3827.5 3827.8 3832.9 3837.5 5506.8 5611.4 5627.1 5641.2 5648.7 5132.4 5141.8 5144.9 5148.8 5148.9 6232.6 6246.7 6251.9 6260.1 6268.2 3985.8 4097.0 4135.0 4207.7 4221.2 6562.6 6578.6 6580.2 6583.2 6608.8 4299.2 4300.9 4311.9 4312.8 4317.1 4233.7 4346.0 4351.3 4357.8 4359.3 5111.4 5118.3 5119.5 5119.9 5130.3 6395.5 6400.9 6404.5 6410.7 6414.9 1533.3 1551.2 1551.7 1554.4 1557.1 1007.8 1025.5 1026.1 1027.3 1033.8 6174.1 6194.4 6196.9 6214.9 6222.6 6601.8 6602.4 6605.3 6607.0 6629.5 6068.4 6197.0 6199.2 6202.8 6214.4 3561.5 3599.6 3609.2 3610.9 3611.3 6866.9 6901.3 6908.6 6914.2 6933.3 6639.0 6761.0 6762.6 6769.3 6775.2 6885.0 6902.7 6902.9 6907.1 6908.6 6580.8 6582.8 6585.9 6588.8 6591.5 6290.2 6467.3 6494.6 6614.9 6616.2 6959.9 6966.2 6976.3 6987.3 6995.3 4355.5 4359.1 4359.7 4361.1 4362.3 6527.5 6633.1 6654.4 6661.6 6670.4 6324.7 6353.8 6443.5 6474.5 6480.6 6298.0 6308.6 6324.7 6326.8 6332.1 6049.8 6191.0 6220.3 6223.1 6233.8 6356.6 6363.2 6368.9 6369.0 6375.0 6116.9 6207.8 6209.8 6230.0 6247.6 22:26:16 INFO - 2015-11-12 22:26:16,212 DEBUG : BROWSER_OUTPUT: 22:26:16 INFO - 2015-11-12 22:26:16,212 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13176.51 Median:24131.50 stddev:15262.60 (63.2%) stddev-sans-first:15276.51 22:26:16 INFO - 2015-11-12 22:26:16,212 DEBUG : BROWSER_OUTPUT: Values: 668.3 694.7 816.5 834.1 870.1 13082.7 13208.0 13274.1 13299.2 13308.9 12441.4 12583.9 12668.9 12674.8 12720.0 665.1 822.6 834.4 834.6 834.6 670.1 810.8 823.9 827.5 831.2 846.4 863.5 863.9 868.4 869.7 688.4 693.2 845.1 845.3 851.9 622.0 628.3 629.0 629.0 631.7 12852.9 12874.0 12975.3 13040.2 13040.4 11434.7 12081.4 12377.6 12457.2 12705.6 9768.3 9808.5 9813.6 9917.9 9953.8 3559.6 3650.9 3671.1 3689.0 3700.7 46380.3 46567.5 46741.0 46783.0 47783.3 9358.7 9791.8 10035.6 10135.2 10148.7 18514.2 18544.9 18618.4 18650.6 18676.6 7212.7 7237.0 7273.8 7323.1 7422.6 4022.7 4127.5 4163.9 4168.7 4183.4 2706.1 2759.2 2965.3 2985.0 2993.8 464.4 471.7 477.1 479.7 480.0 540.8 623.5 633.6 635.5 637.9 7510.7 7516.5 7749.7 8264.4 9236.5 566.0 653.5 656.7 673.2 716.6 3822.2 3843.3 3863.4 3990.9 4218.6 52979.7 53177.5 53355.7 54297.0 55003.0 48085.0 48204.5 48385.3 48800.8 49974.0 43633.0 43911.1 44269.3 45447.8 45709.8 7726.6 8168.0 8359.8 8436.7 8509.7 33444.8 33794.2 34492.7 34564.7 34920.8 42209.8 42726.4 42850.6 42922.8 43021.8 6903.1 6948.6 7108.5 7175.0 7213.1 10686.9 10811.6 10929.8 11282.8 11624.8 10680.4 10781.7 10902.3 11017.7 11212.4 10719.0 11164.4 11190.8 11211.6 11599.0 10047.4 10827.1 10906.0 11078.1 11214.3 9265.8 9471.5 9519.6 9566.0 9592.4 8425.6 8589.1 9204.2 9279.2 9389.7 22:26:16 INFO - 2015-11-12 22:26:16,213 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:26:16 INFO - 2015-11-12 22:26:16,213 DEBUG : BROWSER_OUTPUT: 22:26:16 INFO - 2015-11-12 22:26:16,895 INFO : Browser exited with error code: 0 22:26:16 INFO - 2015-11-12 22:26:16,920 INFO : Completed test dromaeo_css (00:18:35) 22:26:16 INFO - 2015-11-12 22:26:16,920 INFO : Starting test kraken 22:26:16 INFO - 2015-11-12 22:26:16,921 DEBUG : operating with platform_type : linux_ 22:26:16 INFO - 2015-11-12 22:26:16,921 INFO : Initialising browser for kraken test... 22:26:16 INFO - 2015-11-12 22:26:16,927 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp04QWaw/profile http://localhost:57722/getInfo.html 22:26:20 INFO - 2015-11-12 22:26:20,498 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:26:20 INFO - 2015-11-12 22:26:20,498 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:26:20 INFO - 2015-11-12 22:26:20,498 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:26:20 INFO - 2015-11-12 22:26:20,499 DEBUG : BROWSER_OUTPUT: __metrics 22:26:20 INFO - 2015-11-12 22:26:20,655 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:26:21 INFO - 2015-11-12 22:26:21,747 INFO : Browser initialized. 22:26:21 INFO - 2015-11-12 22:26:21,747 INFO : Running cycle 1/1 for kraken test... 22:26:21 INFO - 2015-11-12 22:26:21,747 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp04QWaw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:26:33 INFO - 2015-11-12 22:26:33,531 DEBUG : BROWSER_OUTPUT: RSS: Main: 141369344 22:26:33 INFO - 2015-11-12 22:26:33,532 DEBUG : BROWSER_OUTPUT: 22:26:36 INFO - 2015-11-12 22:26:36,015 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57722/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57722/tests/kraken/driver.html?testName=audio-beat-detection) 22:26:36 INFO - 2015-11-12 22:26:36,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 176369664 22:26:36 INFO - 2015-11-12 22:26:36,596 DEBUG : BROWSER_OUTPUT: 22:26:39 INFO - 2015-11-12 22:26:39,198 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57722/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57722/tests/kraken/driver.html?testName=audio-dft) 22:26:39 INFO - 2015-11-12 22:26:39,764 DEBUG : BROWSER_OUTPUT: RSS: Main: 167837696 22:26:39 INFO - 2015-11-12 22:26:39,764 DEBUG : BROWSER_OUTPUT: 22:26:42 INFO - 2015-11-12 22:26:42,696 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57722/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57722/tests/kraken/driver.html?testName=audio-fft) 22:26:43 INFO - 2015-11-12 22:26:43,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 151408640 22:26:43 INFO - 2015-11-12 22:26:43,258 DEBUG : BROWSER_OUTPUT: 22:26:45 INFO - 2015-11-12 22:26:45,262 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57722/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57722/tests/kraken/driver.html?testName=audio-oscillator) 22:26:45 INFO - 2015-11-12 22:26:45,829 DEBUG : BROWSER_OUTPUT: RSS: Main: 154607616 22:26:45 INFO - 2015-11-12 22:26:45,829 DEBUG : BROWSER_OUTPUT: 22:26:47 INFO - 2015-11-12 22:26:47,990 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57722/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57722/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:26:48 INFO - 2015-11-12 22:26:48,552 DEBUG : BROWSER_OUTPUT: RSS: Main: 154431488 22:26:48 INFO - 2015-11-12 22:26:48,552 DEBUG : BROWSER_OUTPUT: 22:26:51 INFO - 2015-11-12 22:26:51,492 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57722/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57722/tests/kraken/driver.html?testName=imaging-darkroom) 22:26:52 INFO - 2015-11-12 22:26:52,065 DEBUG : BROWSER_OUTPUT: RSS: Main: 155701248 22:26:52 INFO - 2015-11-12 22:26:52,065 DEBUG : BROWSER_OUTPUT: 22:26:55 INFO - 2015-11-12 22:26:55,433 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57722/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57722/tests/kraken/driver.html?testName=imaging-desaturate) 22:26:55 INFO - 2015-11-12 22:26:55,998 DEBUG : BROWSER_OUTPUT: RSS: Main: 155385856 22:26:55 INFO - 2015-11-12 22:26:55,998 DEBUG : BROWSER_OUTPUT: 22:26:58 INFO - 2015-11-12 22:26:58,755 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57722/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57722/tests/kraken/driver.html?testName=json-parse-financial) 22:26:59 INFO - 2015-11-12 22:26:59,321 DEBUG : BROWSER_OUTPUT: RSS: Main: 156221440 22:26:59 INFO - 2015-11-12 22:26:59,321 DEBUG : BROWSER_OUTPUT: 22:27:00 INFO - 2015-11-12 22:27:00,875 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57722/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57722/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:27:01 INFO - 2015-11-12 22:27:01,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 165117952 22:27:01 INFO - 2015-11-12 22:27:01,436 DEBUG : BROWSER_OUTPUT: 22:27:03 INFO - 2015-11-12 22:27:03,205 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57722/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57722/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:27:03 INFO - 2015-11-12 22:27:03,790 DEBUG : BROWSER_OUTPUT: RSS: Main: 164917248 22:27:03 INFO - 2015-11-12 22:27:03,790 DEBUG : BROWSER_OUTPUT: 22:27:05 INFO - 2015-11-12 22:27:05,847 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57722/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57722/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:27:06 INFO - 2015-11-12 22:27:06,421 DEBUG : BROWSER_OUTPUT: RSS: Main: 173592576 22:27:06 INFO - 2015-11-12 22:27:06,421 DEBUG : BROWSER_OUTPUT: 22:27:08 INFO - 2015-11-12 22:27:08,964 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57722/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57722/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:27:09 INFO - 2015-11-12 22:27:09,549 DEBUG : BROWSER_OUTPUT: RSS: Main: 177889280 22:27:09 INFO - 2015-11-12 22:27:09,550 DEBUG : BROWSER_OUTPUT: 22:27:12 INFO - 2015-11-12 22:27:12,117 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57722/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57722/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:27:12 INFO - 2015-11-12 22:27:12,698 DEBUG : BROWSER_OUTPUT: RSS: Main: 176713728 22:27:12 INFO - 2015-11-12 22:27:12,698 DEBUG : BROWSER_OUTPUT: 22:27:14 INFO - 2015-11-12 22:27:14,352 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57722/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57722/tests/kraken/driver.html?testName=ai-astar) 22:27:14 INFO - 2015-11-12 22:27:14,602 DEBUG : BROWSER_OUTPUT: RSS: Main: 236572672 22:27:14 INFO - 2015-11-12 22:27:14,602 DEBUG : BROWSER_OUTPUT: 22:27:14 INFO - 2015-11-12 22:27:14,605 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:27:14 INFO - 2015-11-12 22:27:14,605 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:27:14 INFO - 2015-11-12 22:27:14,606 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:27:14 INFO - 2015-11-12 22:27:14,606 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:27:14 INFO - 2015-11-12 22:27:14,606 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;112;105;111;112;113;100;110;103;111 22:27:14 INFO - 2015-11-12 22:27:14,606 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;173;124;151;165;126;152;151;128;162;125 22:27:14 INFO - 2015-11-12 22:27:14,606 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;161;161;160;161;159;163;161;162 22:27:14 INFO - 2015-11-12 22:27:14,606 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;79;111;72;72;71;96;89;72 22:27:14 INFO - 2015-11-12 22:27:14,607 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;90;130;90;91;91;143;91;92;141 22:27:14 INFO - 2015-11-12 22:27:14,607 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;111;111;111;111;111;111;111;110;110 22:27:14 INFO - 2015-11-12 22:27:14,607 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;146;145;146;145;146;145;145;146 22:27:14 INFO - 2015-11-12 22:27:14,607 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;97;95;95;96;95;95 22:27:14 INFO - 2015-11-12 22:27:14,607 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;57;57;56;57;57;58;65;56;55 22:27:14 INFO - 2015-11-12 22:27:14,607 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;66;66;68;67;68;68;67;67;67 22:27:14 INFO - 2015-11-12 22:27:14,607 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;94;86;85;85;86;86;86;85;85 22:27:14 INFO - 2015-11-12 22:27:14,607 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;119;117;132;120;118;123;115;116;116 22:27:14 INFO - 2015-11-12 22:27:14,608 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;150;149;149;153;141;152;154;150;139 22:27:14 INFO - 2015-11-12 22:27:14,608 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;65;68;65;66;66;65;65;66;65 22:27:14 INFO - 2015-11-12 22:27:14,608 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:27:14 INFO - 2015-11-12 22:27:14,608 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:27:14 INFO - 2015-11-12 22:27:14,608 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,899 22:27:14 INFO - 2015-11-12 22:27:14,608 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:27:14 INFO - 2015-11-12 22:27:14,608 DEBUG : BROWSER_OUTPUT: __startTimestamp1447396034603__endTimestamp 22:27:14 INFO - 2015-11-12 22:27:14,609 DEBUG : BROWSER_OUTPUT: 22:27:14 INFO - 2015-11-12 22:27:14,612 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:27:14 INFO - 2015-11-12 22:27:14,612 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:27:14 INFO - 2015-11-12 22:27:14,612 DEBUG : BROWSER_OUTPUT: 22:27:14 INFO - 2015-11-12 22:27:14,612 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.60 Median:111.00 stddev:4.40 (4.0%) stddev-sans-first:4.67 22:27:14 INFO - 2015-11-12 22:27:14,612 DEBUG : BROWSER_OUTPUT: Values: 109.0 112.0 105.0 111.0 112.0 113.0 100.0 110.0 103.0 111.0 22:27:14 INFO - 2015-11-12 22:27:14,612 DEBUG : BROWSER_OUTPUT: 22:27:14 INFO - 2015-11-12 22:27:14,612 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.70 Median:151.50 stddev:18.50 (12.2%) stddev-sans-first:16.78 22:27:14 INFO - 2015-11-12 22:27:14,612 DEBUG : BROWSER_OUTPUT: Values: 173.0 124.0 151.0 165.0 126.0 152.0 151.0 128.0 162.0 125.0 22:27:14 INFO - 2015-11-12 22:27:14,612 DEBUG : BROWSER_OUTPUT: 22:27:14 INFO - 2015-11-12 22:27:14,613 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.05 (0.7%) stddev-sans-first:1.12 22:27:14 INFO - 2015-11-12 22:27:14,613 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 161.0 161.0 160.0 161.0 159.0 163.0 161.0 162.0 22:27:14 INFO - 2015-11-12 22:27:14,613 DEBUG : BROWSER_OUTPUT: 22:27:14 INFO - 2015-11-12 22:27:14,613 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.60 Median:72.00 stddev:13.73 (19.1%) stddev-sans-first:14.20 22:27:14 INFO - 2015-11-12 22:27:14,613 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 79.0 111.0 72.0 72.0 71.0 96.0 89.0 72.0 22:27:14 INFO - 2015-11-12 22:27:14,613 DEBUG : BROWSER_OUTPUT: 22:27:14 INFO - 2015-11-12 22:27:14,613 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.90 Median:90.50 stddev:23.09 (25.5%) stddev-sans-first:23.85 22:27:14 INFO - 2015-11-12 22:27:14,613 DEBUG : BROWSER_OUTPUT: Values: 90.0 90.0 130.0 90.0 91.0 91.0 143.0 91.0 92.0 141.0 22:27:14 INFO - 2015-11-12 22:27:14,613 DEBUG : BROWSER_OUTPUT: 22:27:14 INFO - 2015-11-12 22:27:14,613 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.60 Median:111.00 stddev:0.70 (0.6%) stddev-sans-first:0.44 22:27:14 INFO - 2015-11-12 22:27:14,613 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 111.0 111.0 111.0 111.0 111.0 111.0 110.0 110.0 22:27:14 INFO - 2015-11-12 22:27:14,613 DEBUG : BROWSER_OUTPUT: 22:27:14 INFO - 2015-11-12 22:27:14,613 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 22:27:14 INFO - 2015-11-12 22:27:14,613 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 146.0 145.0 146.0 145.0 146.0 145.0 145.0 146.0 22:27:14 INFO - 2015-11-12 22:27:14,613 DEBUG : BROWSER_OUTPUT: 22:27:14 INFO - 2015-11-12 22:27:14,614 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 22:27:14 INFO - 2015-11-12 22:27:14,614 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 97.0 95.0 95.0 96.0 95.0 95.0 22:27:14 INFO - 2015-11-12 22:27:14,614 DEBUG : BROWSER_OUTPUT: 22:27:14 INFO - 2015-11-12 22:27:14,614 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.40 Median:57.00 stddev:2.80 (4.9%) stddev-sans-first:2.92 22:27:14 INFO - 2015-11-12 22:27:14,614 DEBUG : BROWSER_OUTPUT: Values: 56.0 57.0 57.0 56.0 57.0 57.0 58.0 65.0 56.0 55.0 22:27:14 INFO - 2015-11-12 22:27:14,614 DEBUG : BROWSER_OUTPUT: 22:27:14 INFO - 2015-11-12 22:27:14,614 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 22:27:14 INFO - 2015-11-12 22:27:14,614 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 66.0 68.0 67.0 68.0 68.0 67.0 67.0 67.0 22:27:14 INFO - 2015-11-12 22:27:14,614 DEBUG : BROWSER_OUTPUT: 22:27:14 INFO - 2015-11-12 22:27:14,614 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:86.00 stddev:2.92 (3.4%) stddev-sans-first:2.88 22:27:14 INFO - 2015-11-12 22:27:14,614 DEBUG : BROWSER_OUTPUT: Values: 83.0 94.0 86.0 85.0 85.0 86.0 86.0 86.0 85.0 85.0 22:27:14 INFO - 2015-11-12 22:27:14,614 DEBUG : BROWSER_OUTPUT: 22:27:14 INFO - 2015-11-12 22:27:14,614 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.70 Median:119.50 stddev:4.99 (4.2%) stddev-sans-first:5.27 22:27:14 INFO - 2015-11-12 22:27:14,614 DEBUG : BROWSER_OUTPUT: Values: 121.0 119.0 117.0 132.0 120.0 118.0 123.0 115.0 116.0 116.0 22:27:14 INFO - 2015-11-12 22:27:14,614 DEBUG : BROWSER_OUTPUT: 22:27:14 INFO - 2015-11-12 22:27:14,614 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.50 Median:150.00 stddev:5.91 (3.9%) stddev-sans-first:5.17 22:27:14 INFO - 2015-11-12 22:27:14,615 DEBUG : BROWSER_OUTPUT: Values: 138.0 150.0 149.0 149.0 153.0 141.0 152.0 154.0 150.0 139.0 22:27:14 INFO - 2015-11-12 22:27:14,615 DEBUG : BROWSER_OUTPUT: 22:27:14 INFO - 2015-11-12 22:27:14,615 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:65.50 stddev:0.97 (1.5%) stddev-sans-first:1.00 22:27:14 INFO - 2015-11-12 22:27:14,615 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 68.0 65.0 66.0 66.0 65.0 65.0 66.0 65.0 22:27:14 INFO - 2015-11-12 22:27:14,615 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:27:14 INFO - 2015-11-12 22:27:14,615 DEBUG : BROWSER_OUTPUT: 22:27:15 INFO - 2015-11-12 22:27:15,495 INFO : Browser exited with error code: 0 22:27:15 INFO - 2015-11-12 22:27:15,546 INFO : Completed test kraken (00:00:58) 22:27:15 INFO - 2015-11-12 22:27:15,546 INFO : Starting test v8_7 22:27:15 INFO - 2015-11-12 22:27:15,546 DEBUG : operating with platform_type : linux_ 22:27:15 INFO - 2015-11-12 22:27:15,546 INFO : Initialising browser for v8_7 test... 22:27:15 INFO - 2015-11-12 22:27:15,552 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLtzPoF/profile http://localhost:57722/getInfo.html 22:27:19 INFO - 2015-11-12 22:27:19,318 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:27:19 INFO - 2015-11-12 22:27:19,318 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:27:19 INFO - 2015-11-12 22:27:19,319 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:27:19 INFO - 2015-11-12 22:27:19,319 DEBUG : BROWSER_OUTPUT: __metrics 22:27:19 INFO - 2015-11-12 22:27:19,496 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:27:20 INFO - 2015-11-12 22:27:20,589 INFO : Browser initialized. 22:27:20 INFO - 2015-11-12 22:27:20,589 INFO : Running cycle 1/1 for v8_7 test... 22:27:20 INFO - 2015-11-12 22:27:20,589 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLtzPoF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:27:32 INFO - 2015-11-12 22:27:32,333 DEBUG : BROWSER_OUTPUT: RSS: Main: 141582336 22:27:32 INFO - 2015-11-12 22:27:32,334 DEBUG : BROWSER_OUTPUT: 22:27:53 INFO - 2015-11-12 22:27:53,815 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57722/tests/v8_7/run.html (next: http://localhost:57722/tests/v8_7/run.html) 22:27:54 INFO - 2015-11-12 22:27:54,061 DEBUG : BROWSER_OUTPUT: RSS: Main: 566689792 22:27:54 INFO - 2015-11-12 22:27:54,061 DEBUG : BROWSER_OUTPUT: 22:27:54 INFO - 2015-11-12 22:27:54,062 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:27:54 INFO - 2015-11-12 22:27:54,062 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:27:54 INFO - 2015-11-12 22:27:54,062 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:27:54 INFO - 2015-11-12 22:27:54,062 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:27:54 INFO - 2015-11-12 22:27:54,062 DEBUG : BROWSER_OUTPUT: |0;Richards;164.33853738701725 22:27:54 INFO - 2015-11-12 22:27:54,062 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.64365214110546 22:27:54 INFO - 2015-11-12 22:27:54,063 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.0078962210942 22:27:54 INFO - 2015-11-12 22:27:54,063 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 22:27:54 INFO - 2015-11-12 22:27:54,063 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1958.9041095890411 22:27:54 INFO - 2015-11-12 22:27:54,063 DEBUG : BROWSER_OUTPUT: |5;Earley;793.0214115781126 22:27:54 INFO - 2015-11-12 22:27:54,063 DEBUG : BROWSER_OUTPUT: |6;Boyer;11732.558139534884 22:27:54 INFO - 2015-11-12 22:27:54,063 DEBUG : BROWSER_OUTPUT: |7;RegExp;26447.36842105263 22:27:54 INFO - 2015-11-12 22:27:54,063 DEBUG : BROWSER_OUTPUT: |8;Splay;610.1281269066504 22:27:54 INFO - 2015-11-12 22:27:54,063 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4882.926829268293 22:27:54 INFO - 2015-11-12 22:27:54,063 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:27:54 INFO - 2015-11-12 22:27:54,063 DEBUG : BROWSER_OUTPUT: __startTimestamp1447396074061__endTimestamp 22:27:54 INFO - 2015-11-12 22:27:54,064 DEBUG : BROWSER_OUTPUT: 22:27:54 INFO - 2015-11-12 22:27:54,064 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:27:54 INFO - 2015-11-12 22:27:54,064 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:27:54 INFO - 2015-11-12 22:27:54,064 DEBUG : BROWSER_OUTPUT: 22:27:54 INFO - 2015-11-12 22:27:54,064 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.34 Median:164.34 stddev:0.00 (0.0%) 22:27:54 INFO - 2015-11-12 22:27:54,064 DEBUG : BROWSER_OUTPUT: Values: 164.3 22:27:54 INFO - 2015-11-12 22:27:54,064 DEBUG : BROWSER_OUTPUT: 22:27:54 INFO - 2015-11-12 22:27:54,064 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.64 Median:188.64 stddev:0.00 (0.0%) 22:27:54 INFO - 2015-11-12 22:27:54,064 DEBUG : BROWSER_OUTPUT: Values: 188.6 22:27:54 INFO - 2015-11-12 22:27:54,064 DEBUG : BROWSER_OUTPUT: 22:27:54 INFO - 2015-11-12 22:27:54,064 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.01 Median:282.01 stddev:0.00 (0.0%) 22:27:54 INFO - 2015-11-12 22:27:54,064 DEBUG : BROWSER_OUTPUT: Values: 282.0 22:27:54 INFO - 2015-11-12 22:27:54,064 DEBUG : BROWSER_OUTPUT: 22:27:54 INFO - 2015-11-12 22:27:54,065 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 22:27:54 INFO - 2015-11-12 22:27:54,065 DEBUG : BROWSER_OUTPUT: Values: 5035.2 22:27:54 INFO - 2015-11-12 22:27:54,065 DEBUG : BROWSER_OUTPUT: 22:27:54 INFO - 2015-11-12 22:27:54,065 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1958.90 Median:1958.90 stddev:0.00 (0.0%) 22:27:54 INFO - 2015-11-12 22:27:54,065 DEBUG : BROWSER_OUTPUT: Values: 1958.9 22:27:54 INFO - 2015-11-12 22:27:54,065 DEBUG : BROWSER_OUTPUT: 22:27:54 INFO - 2015-11-12 22:27:54,065 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:793.02 Median:793.02 stddev:0.00 (0.0%) 22:27:54 INFO - 2015-11-12 22:27:54,065 DEBUG : BROWSER_OUTPUT: Values: 793.0 22:27:54 INFO - 2015-11-12 22:27:54,065 DEBUG : BROWSER_OUTPUT: 22:27:54 INFO - 2015-11-12 22:27:54,065 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11732.56 Median:11732.56 stddev:0.00 (0.0%) 22:27:54 INFO - 2015-11-12 22:27:54,066 DEBUG : BROWSER_OUTPUT: Values: 11732.6 22:27:54 INFO - 2015-11-12 22:27:54,067 DEBUG : BROWSER_OUTPUT: 22:27:54 INFO - 2015-11-12 22:27:54,067 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26447.37 Median:26447.37 stddev:0.00 (0.0%) 22:27:54 INFO - 2015-11-12 22:27:54,067 DEBUG : BROWSER_OUTPUT: Values: 26447.4 22:27:54 INFO - 2015-11-12 22:27:54,067 DEBUG : BROWSER_OUTPUT: 22:27:54 INFO - 2015-11-12 22:27:54,067 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:610.13 Median:610.13 stddev:0.00 (0.0%) 22:27:54 INFO - 2015-11-12 22:27:54,067 DEBUG : BROWSER_OUTPUT: Values: 610.1 22:27:54 INFO - 2015-11-12 22:27:54,067 DEBUG : BROWSER_OUTPUT: 22:27:54 INFO - 2015-11-12 22:27:54,067 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4882.93 Median:4882.93 stddev:0.00 (0.0%) 22:27:54 INFO - 2015-11-12 22:27:54,067 DEBUG : BROWSER_OUTPUT: Values: 4882.9 22:27:54 INFO - 2015-11-12 22:27:54,067 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:27:54 INFO - 2015-11-12 22:27:54,067 DEBUG : BROWSER_OUTPUT: 22:27:54 INFO - 2015-11-12 22:27:54,871 INFO : Browser exited with error code: 0 22:27:54 INFO - 2015-11-12 22:27:54,885 INFO : Completed test v8_7 (00:00:39) 22:27:55 INFO - 2015-11-12 22:27:55,030 INFO : Completed test suite (00:20:13) 22:27:55 INFO - 2015-11-12 22:27:55,030 DEBUG : Working with test: dromaeo_css 22:27:55 INFO - 2015-11-12 22:27:55,030 DEBUG : Generating results file: dromaeo_css 22:27:55 INFO - 2015-11-12 22:27:55,032 DEBUG : Working with test: kraken 22:27:55 INFO - 2015-11-12 22:27:55,032 DEBUG : Generating results file: kraken 22:27:55 INFO - 2015-11-12 22:27:55,032 INFO : javascript benchmark 22:27:55 INFO - 2015-11-12 22:27:55,032 DEBUG : Working with test: v8_7 22:27:55 INFO - 2015-11-12 22:27:55,032 DEBUG : Generating results file: v8_7 22:27:55 INFO - 2015-11-12 22:27:55,033 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:27:55 INFO - 2015-11-12 22:27:55,085 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 22:27:55 INFO - 2015-11-12 22:27:55,085 DEBUG : process_Request line: dromaeo_css 6789.78 graph.html#tests=[[72,64,35]] 22:27:55 INFO - 2015-11-12 22:27:55,085 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:27:55 INFO - 2015-11-12 22:27:55,111 DEBUG : process_Request line: kraken 1495.60 graph.html#tests=[[232,64,35]] 22:27:55 INFO - 2015-11-12 22:27:55,111 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:27:55 INFO - 2015-11-12 22:27:55,137 DEBUG : process_Request line: v8_7 19920.11 graph.html#tests=[[230,64,35]] 22:27:55 INFO - 2015-11-12 22:27:55,139 INFO : javascript benchmark 22:27:55 INFO - 2015-11-12 22:27:55,143 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [310.9639390077691, 313.7772181750957, 321.8471226167571, 334.12792611284544, 337.7821305258109, 10258.07677309042, 10648.680539583826, 12069.275843449388, 16633.750493742602, 17224.827751722496, 16914.66170676586, 17014.40449584265, 17017.2342244599, 17179.141042947835, 17256.223469943852, 5716.542676585863, 6000.969995150018, 6003.879922401549, 6004.939950600504, 6008.759649614032, 4189.706720529564, 4266.0, 5943.286805583336, 6595.967020164892, 6854.143232095988, 6625.60246385216, 6774.5257831951785, 6775.1531058617675, 6819.420349270318, 6833.726650933957, 6918.827029324282, 6959.269276725972, 6969.546979446345, 6972.825679358006, 6976.093107895967, 6156.538259630545, 6371.23545174582, 6377.7767778127545, 6659.9001014984815, 6672.299408562079, 21408.0, 23202.0, 23480.76519234803, 23563.646545301835, 23594.528109437888, 1946.3285166617495, 1955.071341112974, 1991.7410736604293, 2082.6355387807075, 2162.589108069462, 13478.865211347858, 13644.727105457934, 13964.511242106579, 14101.64745881351, 14120.903553958866, 1831.5878927241397, 1890.3100368365585, 1914.1290712725815, 1926.6339395514808, 1939.3697048459308, 66900.0, 68036.6598167006, 68682.31317686859, 68975.65512172457, 70206.29793702048, 14658.267086645625, 15015.399384024735, 15337.309821057856, 15438.150901700514, 15480.767788483181, 23978.640320395207, 24016.759832401804, 24217.304788664977, 24248.393790155387, 24254.151104711604, 8491.915080849236, 8543.743687689379, 8600.440971336842, 8615.913840861636, 8665.523396213268, 7259.092613423322, 7279.818004549823, 7316.890246646304, 7320.450966177558, 7340.559566426032, 6515.250746164157, 7504.887426688604, 7589.506682065648, 7702.422318326148, 7757.379409647215, 2703.891844326205, 2979.6275465566805, 2980.8211507309197, 3025.6823033581595, 3065.11111777582, 409.0673264955905, 424.7727465805779, 430.9956900430956, 436.46315032509557, 450.79263538772534, 10620.415877126832, 11843.407829608657, 11860.881391185978, 12000.639980800415, 12085.45615447307, 439.79329715033884, 444.02314907204277, 449.4718705521, 452.7351499372838, 454.8771831605448, 6261.186045814015, 6483.3192514786215, 6500.0, 6514.934850651528, 6648.235452922879, 477740.0, 490325.0, 540633.0, 542428.0, 542526.0, 66875.0, 67533.0, 68816.0, 71200.0, 76224.61887690525, 485.54843995084207, 491.63127654259307, 495.09891996566625, 495.34366963773147, 495.9107360675113, 10656.89343106559, 10926.50830712604, 11333.603323883624, 11405.429728513707, 11480.311181329147, 31828.36343273168, 32244.677553224166, 32771.99999999905, 35217.64782352144, 35233.0, 43377.783111084245, 45541.31688024748, 47018.29472557846, 47506.28740568825, 52182.739086304326, 14451.566453006426, 14472.927635361755, 15054.623634409227, 15175.620609484851, 15188.392464301303, 18617.81382186215, 18854.3400980965, 18875.811241887954, 19409.0, 19784.505387365432, 15503.0, 15578.766318505004, 15722.685546288782, 15801.920990394974, 16048.19759012068, 8566.957165214135, 8729.170728780755, 14867.92566037163, 15556.533304000897, 15646.139462329225, 8715.694950676696, 8846.336524760798, 8913.197812196933, 8989.775255618662, 8993.640254389751, 13957.255343082115, 14333.0, 14405.9279703605, 14620.195889226196, 14633.122012679274, 8513.95743021281, 8841.204291613785, 8997.055309192703, 15555.922220388826, 15600.375984960474], "dojo.html": [3128.7653425993053, 3270.411325961326, 3302.8018318900868, 3304.1078908694653, 3310.271740217152, 5159.097157997354, 5298.0, 5440.673559586423, 5452.400235974044, 5461.235427040213, 5304.867378315544, 5353.625246232756, 5358.062339090663, 5365.168398898168, 5467.753951072202, 4936.111499930011, 4936.7778449969655, 5018.849434516952, 5060.418051924021, 5137.691738495702, 5033.471485494026, 5054.444011158769, 5118.820841270556, 5131.127708289581, 5202.739863006854, 4825.710457372551, 4915.754212289407, 4916.58209052231, 5020.0, 5040.999999999964, 5006.249062640597, 5013.899722005576, 5023.673461225045, 5026.623003274769, 5056.519630635084, 4826.638002149818, 4983.775730092155, 4985.0, 5017.523335283142, 5059.620528460343, 5113.51421614946, 5167.147420675584, 5186.896262074737, 5203.531682148587, 5214.426413094557, 5824.126381042835, 5824.417558244184, 5827.155062515912, 5838.241028666289, 5857.853553661193, 5488.341399032141, 5585.050541407971, 5874.588778785486, 5883.14694369314, 5886.146508756249, 5446.210299506589, 5505.421930697299, 5510.201020851954, 5517.944820551783, 5567.053600887859, 5924.437178468039, 5930.9406905931255, 5933.228680271537, 5940.108983652401, 5946.286445626552, 5545.916811247835, 5686.260786097863, 5752.511036561939, 5775.5668324875805, 5783.624064435799, 5866.911996320058, 5872.148538461899, 5876.324222714357, 5894.764209431661, 5935.2877654681715, 5839.416058394211, 5843.415658434207, 5849.239598852122, 5850.210221620112, 5852.180694702745, 5709.74306156224, 5755.251817263729, 5801.332846722681, 5864.677442740605, 5869.413058694182, 4486.618637415856, 4500.887477813081, 4517.435320584927, 4527.637788976874, 4566.680332376702, 3995.6403923647013, 4009.258287216874, 4024.7987600620436, 4041.1513582148077, 4047.7166598337835, 5259.894802103937, 5274.077036518671, 5448.346198456132, 5450.209719590637, 5471.124620060771, 5857.7656893724625, 5881.823545293562, 5886.440788125121, 5893.734781934823, 5896.3219229788265, 5501.504864562208, 5508.256385388001, 5522.144067669517, 5530.142827861688, 5532.0, 4936.75316234194, 5026.824061157842, 5054.7472626368535, 5113.181890897438, 5165.586753059746, 6189.6286222826775, 6208.627482351073, 6209.844753881189, 6214.658193799294, 6220.346863579259, 5756.2229099072765, 5945.64326140433, 5965.612235204698, 5974.581779275409, 5983.0, 6024.9397506026135, 6070.7392945915835, 6101.359357267423, 6116.755329786759, 6118.284172697687, 5734.54123670097, 5736.082226843685, 5739.225204597493, 5747.453991870766, 5825.2135961644635, 5675.631083979528, 5811.76752929895, 5823.854403639943, 5828.650280982985, 5833.183354330312, 5589.664620122806, 5646.520045795989, 5654.575906807088, 5669.007923613433, 5721.284839395075, 5748.913766293593, 5780.161876527795, 5784.479396854135, 5791.47876691083, 5801.738921748447, 5412.78348866041, 5532.0595498766115, 5688.687122208318, 5689.032864413142, 5689.34572524165, 5696.231008813757, 5700.515456186271, 5790.913136302875, 5818.709064546841, 5864.67744274069, 5674.517665998436, 5675.716214189357, 5677.716114194356, 5686.147077938343, 5733.569982251264], "mootools.html": [1354.3566805767268, 1678.1022153148067, 1696.8303169683034, 1743.1284357821094, 1751.5708651380414, 6152.938470615298, 6708.832279193022, 6852.7944161675105, 6854.177498700163, 6869.278725733801, 6803.829904252384, 6934.063901373325, 6945.0, 6949.722011119549, 6954.0959675242275, 1878.614883948787, 1904.8190421909896, 2093.0685844799073, 2147.860389074713, 2167.8482506224573, 2123.8407119466024, 2132.1471411435396, 2134.0930104705517, 2139.21918499748, 2178.357384571555, 2119.290037837319, 2196.9121235150574, 2209.1936443198197, 2209.414505156135, 2217.4456385903522, 1935.4097000414868, 1973.3487948976804, 2095.31902131807, 2141.1649456711893, 2141.3040761752336, 2156.2453141400542, 2159.546495236002, 2198.1756841184556, 2198.769129241439, 2202.3282898715884, 6870.725170993154, 6935.306469353075, 6942.72229110835, 6969.930300697029, 6973.442124630017, 4161.729487583328, 4235.089455767024, 4256.063665993476, 4260.510041345223, 4262.850800222009, 2752.3118424065046, 2807.03157410693, 2808.9719102808913, 2840.9857950710116, 2858.1139846647397, 844.6452489954172, 851.7402192331336, 864.0797550608645, 888.7244954064196, 889.8754174415587, 9633.0, 9694.854577181277, 9702.320837541374, 9705.272104592184, 9721.222302215876, 3791.829367678461, 3845.384738441836, 3871.9612803872164, 3895.590962948906, 3920.9215815684097, 8092.676292948334, 8131.715389961323, 8140.063892652421, 8150.0, 8156.939597852242, 4201.264778663722, 4221.366794980716, 4223.852165174204, 4228.4080228768, 4229.154169166179, 3903.0, 3926.646601805794, 3932.4297976793778, 3957.2679054375035, 3957.406389041609, 3382.5602671652528, 3408.931821363559, 3412.7269818414466, 3413.2832105257676, 3431.605365382963, 1145.5646854195352, 1149.1209224942925, 1171.7305019845483, 1172.806486929647, 1176.529388244709, 871.899731530882, 1205.1925210109248, 1208.546794951893, 1209.7520008398258, 1231.655136561764, 5770.480656740913, 6491.156149700509, 6724.327567243236, 6726.495512836459, 6735.865282694319, 666.1939053745023, 667.8263651450561, 680.5406350713249, 693.1785833786979, 694.7429451103023, 4707.576318131385, 4716.151092803259, 4733.644976626767, 4743.810247590127, 4745.383100197021, 8150.0, 8193.631286592117, 8341.708040218564, 8348.415610907177, 8348.499090054616, 8329.66681332752, 8498.362622803315, 8529.957350213333, 8578.485290882567, 8582.442141260799, 6702.832429189211, 6722.731090756315, 6722.764703235461, 6752.5273230874345, 6769.526133170729, 5853.970730146322, 5918.911216331672, 5957.076653118774, 5997.580169388101, 5999.730012149551, 7462.291082347168, 7531.284527969834, 7546.698132074655, 7594.8101297468, 7633.465657403928, 7597.810054748676, 7773.805654858674, 7793.454458187873, 7803.336716379172, 7939.841203175789, 6209.037599172136, 6243.282022567463, 6246.437820596168, 6254.874902501833, 6259.78090766821, 6787.796366109024, 6846.863062738817, 6848.3494068063455, 6868.553544019623, 6899.931000689929, 6463.450606698295, 6505.804825855232, 6527.281998980014, 6536.0522724205675, 6546.639934803631, 6255.499560035278, 6384.3934826191435, 6386.680665966776, 6494.935050649433, 6504.707288171949, 6036.637801731735, 6120.418560236771, 6167.321594624677, 6170.475509581735, 6173.475254603409, 5737.139429085671, 5754.194412782297, 5756.740946657326, 5759.136129580429, 5762.279715035621, 5675.886482270249, 5711.200431939615, 5755.107958266475, 5764.625299355528, 5778.913316300343], "ext.html": [577.7284676202186, 584.9327327357353, 596.1028651878922, 603.5292471871942, 605.071215683925, 31302.843485782567, 32198.839005804966, 39985.60014399855, 40461.59538404615, 40513.189736205255, 42057.579424205745, 42634.7868260659, 42846.0, 43046.13907721844, 43063.35404968928, 8515.361347898901, 8685.522296273703, 8696.521691306976, 8699.0, 8782.736517904474, 7687.0391201099865, 7858.607069646523, 10475.109615682675, 10690.144788416908, 10704.78590428191, 10312.0, 10418.062374386303, 10431.426271555061, 10432.895671043307, 10433.16534677224, 7654.732084377076, 7844.294013538809, 10335.0, 10464.895351046544, 10466.581336746522, 10449.895501044968, 10613.787724245549, 10635.776885658172, 10668.733281667943, 10676.786464270748, 38906.22187556233, 39280.41079383811, 39321.0, 39374.60625393738, 39376.80311598453, 3031.5452682097643, 3082.291073053188, 3114.9221269468444, 3184.9363012739846, 3605.314990151889, 30355.848220758755, 30483.0, 30730.385392292254, 30746.846265768527, 31487.685123148705, 3351.949720754191, 3353.295807880348, 3354.647761985005, 3385.0691059958463, 3461.5326930864517, 273052.0, 274046.0, 274212.0, 274321.0, 274519.0, 53462.465375345746, 54454.18318725222, 55284.617884552405, 57653.135202971986, 58563.70718146382, 54314.45685543173, 54415.18377224345, 54615.18077228845, 54656.18015729767, 54702.0, 13702.588922332347, 13821.79267310991, 13985.510507132201, 14079.648008799657, 14103.647408814863, 10177.643782467578, 10249.538770755185, 10260.486975651187, 10287.177025837915, 10314.896851031393, 18420.723689144674, 18607.53481162982, 18724.906375468036, 18806.623867522572, 18830.24679012824, 7152.463565232629, 7425.888611670829, 7475.803871380553, 7523.849523009619, 7544.283293087148, 941.4539567051231, 947.8578213267928, 1005.4369553050316, 1011.9241056920761, 1034.8395998620226, 28431.147065588066, 28476.572851407247, 28596.0, 28918.132456026353, 29001.419971600873, 975.6926568131016, 991.9057689519484, 1050.6690392526482, 1066.0618655583037, 1097.1771171621283, 13315.733685326433, 13369.866301337057, 13509.59471215865, 13549.119307244997, 13662.931685341708, 318364.0, 318761.0, 321141.0, 321769.0, 321993.0, 48623.27065094026, 48850.75574622175, 48871.5112848867, 48951.51048489541, 49002.0, 1315.6447759104988, 1319.957233785318, 1329.4881470633875, 1342.8455727591256, 1344.1464669934467, 22042.559148817254, 27592.0, 27661.723382765915, 28242.43515129645, 28358.0, 43216.35175472433, 43225.0, 43585.34621980736, 43684.781576093184, 43691.0, 263600.63993601257, 264551.0, 265211.0, 267624.0, 267899.0, 27131.59302610502, 27652.861735691193, 30262.0, 30607.387852243275, 31484.212894677818, 37769.244615106996, 37941.0, 37998.810005949796, 38028.809855950545, 38763.2247355057, 32522.34955300928, 33592.49611255882, 34328.31343373169, 34837.47743783896, 35699.64300356963, 28184.65153793332, 32967.34065318728, 33921.49117763186, 34917.30165396729, 35589.0, 32093.197670058435, 32461.350772983937, 32697.18257043593, 32796.34407311793, 32834.343313133126, 28896.844126235555, 31007.0, 31380.843095784374, 31618.841905791243, 31671.683283166873, 23255.3023409298, 23421.180258690863, 23669.934852931314, 23927.401814954766, 24023.27930162098], "prototype.html": [281.39500074839094, 283.8864454218313, 284.37863268757764, 285.1516737705328, 290.474241622663, 5862.648241105537, 5973.313068997067, 6002.399760023995, 6033.577649564532, 6043.939560604398, 5777.7977770777925, 5917.585768996172, 5937.821865344035, 5944.256967879015, 5961.344252132262, 4434.645228381738, 4438.755868427235, 4446.822127114928, 4467.7542735149555, 4471.195184866723, 4262.616364527192, 4350.303951367781, 4366.868993930171, 4426.667999900004, 4471.105778844228, 4429.092036132585, 4429.667774916878, 4434.756088415136, 4435.467743870724, 4457.242268814293, 4423.049044455457, 4427.446569178853, 4431.534688857688, 4435.334699795024, 4438.755868427235, 3823.674987626055, 3827.540695116576, 3827.789471579062, 3832.885013449601, 3837.539495260559, 5506.834794956158, 5611.438856114397, 5627.099664053772, 5641.2384328116, 5648.717564121777, 5132.358455193101, 5141.820036298712, 5144.897102057976, 5148.84553463393, 5148.922766158511, 6232.594881332699, 6246.6876656167005, 6251.906221406683, 6260.060990851363, 6268.216472940882, 3985.8405663773415, 4096.959030409717, 4135.028268356934, 4207.663386929069, 4221.2190744712325, 6562.573432726857, 6578.63817490033, 6580.24327202373, 6583.177102862142, 6608.801735947881, 4299.1831552005015, 4300.935485967713, 4311.8706438806885, 4312.849050283225, 4317.050248945227, 4233.682473814476, 4346.043870348518, 4351.3255445405375, 4357.779821649943, 4359.324304732771, 5111.386633603917, 5118.25785261135, 5119.539241468286, 5119.923201151985, 5130.256112863689, 6395.52033597482, 6400.9039864402075, 6404.48764098871, 6410.711517981702, 6414.903776443264, 1533.279358701431, 1551.1623723189352, 1551.6663917257845, 1554.35494269879, 1557.0891028748308, 1007.8286691262502, 1025.4923812712755, 1026.0611540440564, 1027.2603725317758, 1033.8035773203067, 6174.073888916699, 6194.38056194377, 6196.946519091765, 6214.937850621436, 6222.62664240147, 6601.8349541260895, 6602.372774586406, 6605.273419923805, 6607.0, 6629.469642428594, 6068.362821903725, 6197.03945888388, 6199.163112979781, 6202.751889924442, 6214.378562143749, 3561.465780133001, 3599.6040435552068, 3609.151849315409, 3610.9277814443562, 3611.3499570077115, 6866.896996545056, 6901.275366086589, 6908.620025898624, 6914.239433662293, 6933.2720064392515, 6638.966805165944, 6760.966195168992, 6762.594244345355, 6769.289224631441, 6775.186977562724, 6884.965575172192, 6902.723891044302, 6902.8619427612175, 6907.067545881242, 6908.5509441886115, 6580.76967306142, 6582.76960306387, 6585.901211481927, 6588.769393071411, 6591.549859031005, 6290.150829637941, 6467.256265529524, 6494.577852439576, 6614.933850661432, 6616.2391324996315, 6959.930400695928, 6966.164060312795, 6976.267491913276, 6987.266337034538, 6995.335443132894, 4355.49911760139, 4359.128174365076, 4359.738415695068, 4361.12777444506, 4362.345648152803, 6527.5430719849155, 6633.104530888461, 6654.367835055662, 6661.633610151488, 6670.39966403026, 6324.683765811783, 6353.809385718436, 6443.484521238383, 6474.546781725422, 6480.611163330215, 6297.960836462115, 6308.558400911892, 6324.715387807468, 6326.841828954313, 6332.145160403471, 6049.758009679564, 6190.969045154746, 6220.284667263322, 6223.097650840512, 6233.75064997395, 6356.618602883842, 6363.172787537591, 6368.936310636835, 6369.01280301554, 6374.968125159345, 6116.877662446637, 6207.782727604512, 6209.844753881189, 6229.972054611119, 6247.5939063960695], "yui.html": [668.3283300283215, 694.7464175575915, 816.4896939412866, 834.0899340510229, 870.142909234404, 13082.73834523309, 13208.0, 13274.137181083222, 13299.202047877134, 13308.933455332734, 12441.37793110343, 12583.874161258385, 12668.936655316733, 12674.809877851816, 12720.045996550249, 665.1486097794806, 822.6421506644614, 834.4034015678789, 834.5535138700797, 834.5618550261131, 670.0518765946181, 810.8256724804166, 823.9258466737992, 827.4952279109739, 831.2020460358063, 846.3525403066659, 863.5078005536847, 863.926566241867, 868.3791089371099, 869.7477731457869, 688.3942130924804, 693.1958927643909, 845.121074082953, 845.3026253340987, 851.9318454523655, 621.9720112594944, 628.2617923939353, 629.0093103362223, 629.0469938043867, 631.7188850961325, 12852.935735321356, 12874.0, 12975.286359250238, 13040.217586944718, 13040.413181406859, 11434.656960291204, 12081.395930203455, 12377.62867113988, 12457.1902826316, 12705.555305564261, 9768.267379946532, 9808.509574521246, 9813.607455701764, 9917.90082099177, 9953.75115622108, 3559.5906470755676, 3650.908727281813, 3671.1372827385812, 3689.0, 3700.7409481336317, 46380.3042954356, 46567.534324657, 46741.0, 46783.0, 47783.283250751614, 9358.672446464341, 9791.804163916682, 10035.648752293635, 10135.189184865194, 10148.695539133838, 18514.16686249122, 18544.907275463538, 18618.44144675662, 18650.626987460175, 18676.626467470847, 7212.7114915403845, 7236.963815180996, 7273.818154546073, 7323.121225452873, 7422.591757453392, 4022.738521996061, 4127.484064491939, 4163.8959026024595, 4168.651266174507, 4183.351580504966, 2706.066407089551, 2759.227416323433, 2965.2883308006353, 2984.9552256716165, 2993.7904346695523, 464.3615029334665, 471.6839717389357, 477.1340017867559, 479.72655586316165, 479.95920346770913, 540.7863893761942, 623.4918541388754, 633.6419922743635, 635.4693830651457, 637.9330170332141, 7510.6620202091035, 7516.549007059594, 7749.651265693057, 8264.380171487042, 9236.491992940453, 565.9632123911932, 653.4772182254178, 656.714329266761, 673.1806797144891, 716.6416791604198, 3822.2164456286396, 3843.3082045231567, 3863.439801228806, 3990.9002274942777, 4218.620324170839, 52979.735101324244, 53177.46822531725, 53355.73322133442, 54297.0, 55003.0, 48085.0, 48204.5179548207, 48385.27422088671, 48800.755996220505, 49974.0, 43633.0, 43911.121777564906, 44269.33595996063, 45447.77276113598, 45709.77145114253, 7726.613669316399, 8168.0, 8359.832803344021, 8436.74667485079, 8509.74470765878, 33444.83277583597, 33794.15514612154, 34492.65507344894, 34564.65435345614, 34920.82539587286, 42209.788951055045, 42726.35910461408, 42850.57149428466, 42922.78538607287, 43021.784891075346, 6903.1371078615175, 6948.583085014915, 7108.537945033556, 7175.03137076488, 7213.134423869169, 10686.893639062071, 10811.6215932442, 10929.836052459379, 11282.7743445129, 11624.767504650028, 10680.412577308323, 10781.676549703521, 10902.291351062155, 11017.724556886142, 11212.43937803123, 10719.0, 11164.441777911234, 11190.83213751778, 11211.55153793839, 11599.0, 10047.447390393598, 10827.13382929348, 10906.0, 11078.05836503874, 11214.327140371604, 9265.768355791159, 9471.47906865129, 9519.57161927701, 9566.0, 9592.376495527767, 8425.578721064045, 8589.14108589136, 9204.217641500547, 9279.164875161268, 9389.718308450758]}, "summary": {"lowerIsBetter": false, "suite": 6789.775795696985, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 8848.500271501982, "unit": "ms", "value": 8848.500271501982}, "dojo.html": {"lowerIsBetter": false, "filtered": 5390.35349764673, "unit": "ms", "value": 5390.35349764673}, "mootools.html": {"lowerIsBetter": false, "filtered": 4040.042120391154, "unit": "ms", "value": 4040.042120391154}, "ext.html": {"lowerIsBetter": false, "filtered": 17926.261315443433, "unit": "ms", "value": 17926.261315443433}, "prototype.html": {"lowerIsBetter": false, "filtered": 4715.278235246004, "unit": "ms", "value": 4715.278235246004}, "yui.html": {"lowerIsBetter": false, "filtered": 6014.795333864602, "unit": "ms", "value": 6014.795333864602}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-068"}, "testrun": {"date": 1447394861, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112203045", "branch": "Fx-Team", "revision": "4b2ec935bc99bc505776190210b11dfe552bd041"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 161.0, 161.0, 161.0, 160.0, 161.0, 159.0, 163.0, 161.0, 162.0], "ai-astar": [109.0, 112.0, 105.0, 111.0, 112.0, 113.0, 100.0, 110.0, 103.0, 111.0], "imaging-gaussian-blur": [109.0, 111.0, 111.0, 111.0, 111.0, 111.0, 111.0, 111.0, 110.0, 110.0], "audio-beat-detection": [173.0, 124.0, 151.0, 165.0, 126.0, 152.0, 151.0, 128.0, 162.0, 125.0], "json-stringify-tinderbox": [67.0, 66.0, 66.0, 68.0, 67.0, 68.0, 68.0, 67.0, 67.0, 67.0], "stanford-crypto-pbkdf2": [138.0, 150.0, 149.0, 149.0, 153.0, 141.0, 152.0, 154.0, 150.0, 139.0], "json-parse-financial": [56.0, 57.0, 57.0, 56.0, 57.0, 57.0, 58.0, 65.0, 56.0, 55.0], "stanford-crypto-sha256-iterative": [65.0, 65.0, 68.0, 65.0, 66.0, 66.0, 65.0, 65.0, 66.0, 65.0], "audio-fft": [72.0, 72.0, 79.0, 111.0, 72.0, 72.0, 71.0, 96.0, 89.0, 72.0], "imaging-darkroom": [145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0], "stanford-crypto-ccm": [121.0, 119.0, 117.0, 132.0, 120.0, 118.0, 123.0, 115.0, 116.0, 116.0], "audio-oscillator": [90.0, 90.0, 130.0, 90.0, 91.0, 91.0, 143.0, 91.0, 92.0, 141.0], "stanford-crypto-aes": [83.0, 94.0, 86.0, 85.0, 85.0, 86.0, 86.0, 86.0, 85.0, 85.0], "imaging-desaturate": [95.0, 95.0, 95.0, 95.0, 97.0, 95.0, 95.0, 96.0, 95.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1495.5999999999997, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 80.6, "unit": "ms", "value": 80.6}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 147.5, "unit": "ms", "value": 147.5}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 145.7, "unit": "ms", "value": 145.7}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 119.7, "unit": "ms", "value": 119.7}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.5, "unit": "ms", "value": 145.5}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 57.4, "unit": "ms", "value": 57.4}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 104.9, "unit": "ms", "value": 104.9}, "ai-astar": {"lowerIsBetter": true, "filtered": 108.6, "unit": "ms", "value": 108.6}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.0, "unit": "ms", "value": 161.0}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 65.6, "unit": "ms", "value": 65.6}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 67.1, "unit": "ms", "value": 67.1}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 110.6, "unit": "ms", "value": 110.6}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 86.1, "unit": "ms", "value": 86.1}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.3, "unit": "ms", "value": 95.3}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-068"}, "testrun": {"date": 1447394861, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112203045", "branch": "Fx-Team", "revision": "4b2ec935bc99bc505776190210b11dfe552bd041"}}, {"talos_counters": {}, "results": {"DeltaBlue": [188.64365214110546], "Encrypt": [282.0078962210942], "NavierStokes": [4882.926829268293], "Decrypt": [5035.175879396985], "Splay": [610.1281269066504], "Richards": [164.33853738701725], "RegExp": [26447.36842105263], "Earley": [793.0214115781126], "Boyer": [11732.558139534884], "RayTrace": [1958.9041095890411]}, "summary": {"lowerIsBetter": false, "suite": 19920.108776540135, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 350.49151800000004, "unit": "score", "value": 350.49151800000004}, "Encrypt": {"lowerIsBetter": false, "filtered": 943.8778259999998, "unit": "score", "value": 943.8778259999998}, "NavierStokes": {"lowerIsBetter": false, "filtered": 303.91608391608383, "unit": "score", "value": 303.91608391608383}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.864290419161705, "unit": "score", "value": 52.864290419161705}, "Splay": {"lowerIsBetter": false, "filtered": 133.56374900000003, "unit": "score", "value": 133.56374900000003}, "RegExp": {"lowerIsBetter": false, "filtered": 34.44520398009948, "unit": "score", "value": 34.44520398009948}, "Richards": {"lowerIsBetter": false, "filtered": 214.81267000000008, "unit": "score", "value": 214.81267000000008}, "Earley": {"lowerIsBetter": false, "filtered": 840.4098429999997, "unit": "score", "value": 840.4098429999997}, "Boyer": {"lowerIsBetter": false, "filtered": 56.80457680872147, "unit": "score", "value": 56.80457680872147}, "RayTrace": {"lowerIsBetter": false, "filtered": 377.7566223776223, "unit": "score", "value": 377.7566223776223}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-068"}, "testrun": {"date": 1447394861, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112203045", "branch": "Fx-Team", "revision": "4b2ec935bc99bc505776190210b11dfe552bd041"}}] 22:27:55 INFO - RETURN: dromaeo_css: 6789.78 22:27:55 INFO - RETURN: kraken: 1495.60 22:27:55 INFO - RETURN: v8_7: 19920.11 22:27:55 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19920.11"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1495.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6789.78"}}} 22:27:55 INFO - Return code: 0 22:27:55 INFO - # TBPL SUCCESS # 22:27:55 INFO - Running post-action listener: _resource_record_post_action 22:27:55 INFO - Running post-run listener: _resource_record_post_run 22:27:56 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 10436608; Write bytes: 404541440; Read time: 2240; Write time: 410560 22:27:56 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 4501504; Read time: 0; Write time: 436 22:27:56 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 8245248; Write bytes: 400039936; Read time: 2120; Write time: 410124 22:27:56 INFO - Running post-run listener: _upload_blobber_files 22:27:56 INFO - Blob upload gear active. 22:27:56 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:27:56 INFO - Copying logs to upload dir... 22:27:56 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1279.877700 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-11-12 22:27:56.336143) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 22:27:56.339332) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1447394334.150226-603385331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009855 build_url: 'https://queue.taskcluster.net/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 22:27:56.395673) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 22:27:56.396485) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1447394334.150226-603385331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 22:27:56.450595) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 22:27:56.451368) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 22:27:56.452016) ========= ========= Total master_lag: 0.26 =========