builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1447223329.06 results: success (0) buildid: 20151110205155 builduid: 754f5f87d4744965bcfbf2e2d79c8255 revision: 5ce07357c5f7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-10 22:28:49.062124) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-10 22:28:49.062576) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-10 22:28:49.063122) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1447222890.726413-970869175 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006441 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-10 22:28:49.085443) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-10 22:28:49.085730) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-10 22:28:49.117299) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 22:28:49.117549) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1447222890.726413-970869175 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004608 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 22:28:49.167100) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-10 22:28:49.167427) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-10 22:28:49.167825) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 22:28:49.168101) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1447222890.726413-970869175 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-10 22:28:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.2M=0s 2015-11-10 22:28:49 (47.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167751 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 22:28:49.347544) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 22:28:49.347847) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1447222890.726413-970869175 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019131 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 22:28:49.396632) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-10 22:28:49.396932) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5ce07357c5f7 --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/mozilla-inbound --rev 5ce07357c5f7 --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=d16fe3a243cfe9e60ec7df77000001e0-1447222890.726413-970869175 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-10 22:28:49,818 Setting DEBUG logging. 2015-11-10 22:28:49,818 attempt 1/10 2015-11-10 22:28:49,818 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/5ce07357c5f7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-10 22:28:50,712 unpacking tar archive at: mozilla-inbound-5ce07357c5f7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.160987 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-10 22:28:50.570984) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-10 22:28:50.571331) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-10 22:28:50.580776) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-10 22:28:50.581137) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-10 22:28:50.581754) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2015-11-10 22:28:50.582074) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d16fe3a243cfe9e60ec7df77000001e0-1447222890.726413-970869175 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:28:51 INFO - MultiFileLogger online at 20151110 22:28:51 in /builds/slave/test-pgo 22:28:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 22:28:51 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:28:51 INFO - {'append_to_log': False, 22:28:51 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:28:51 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:28:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:28:51 INFO - 'branch': 'Mozilla-Inbound', 22:28:51 INFO - 'buildbot_json_path': 'buildprops.json', 22:28:51 INFO - 'config_files': ('talos/linux_config.py',), 22:28:51 INFO - 'default_actions': ('clobber', 22:28:51 INFO - 'read-buildbot-config', 22:28:51 INFO - 'download-and-extract', 22:28:51 INFO - 'populate-webroot', 22:28:51 INFO - 'create-virtualenv', 22:28:51 INFO - 'install', 22:28:51 INFO - 'run-tests'), 22:28:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:28:51 INFO - 'download_minidump_stackwalk': True, 22:28:51 INFO - 'download_symbols': 'ondemand', 22:28:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:28:51 INFO - 'tooltool.py': '/tools/tooltool.py', 22:28:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:28:51 INFO - '/tools/misc-python/virtualenv.py')}, 22:28:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:28:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:28:51 INFO - 'installer_path': 'installer.exe', 22:28:51 INFO - 'log_level': 'info', 22:28:51 INFO - 'log_name': 'talos', 22:28:51 INFO - 'log_to_console': True, 22:28:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:28:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:28:51 INFO - 'opt_config_files': (), 22:28:51 INFO - 'pip_index': False, 22:28:51 INFO - 'sps_profile': False, 22:28:51 INFO - 'sps_profile_interval': 0, 22:28:51 INFO - 'suite': 'dromaeojs', 22:28:51 INFO - 'system_bits': '64', 22:28:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:28:51 INFO - 'title': 'talos-linux64-ix-034', 22:28:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:28:51 INFO - 'use_talos_json': True, 22:28:51 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:28:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:28:51 INFO - 'work_dir': 'build'} 22:28:51 INFO - ##### 22:28:51 INFO - ##### Running clobber step. 22:28:51 INFO - ##### 22:28:51 INFO - Running pre-action listener: _resource_record_pre_action 22:28:51 INFO - Running main action method: clobber 22:28:51 INFO - rmtree: /builds/slave/test-pgo/build 22:28:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:28:52 INFO - Running post-action listener: _resource_record_post_action 22:28:52 INFO - ##### 22:28:52 INFO - ##### Running read-buildbot-config step. 22:28:52 INFO - ##### 22:28:52 INFO - Running pre-action listener: _resource_record_pre_action 22:28:52 INFO - Running main action method: read_buildbot_config 22:28:52 INFO - Using buildbot properties: 22:28:52 INFO - { 22:28:52 INFO - "properties": { 22:28:52 INFO - "buildnumber": 542, 22:28:52 INFO - "product": "firefox", 22:28:52 INFO - "script_repo_revision": "production", 22:28:52 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 22:28:52 INFO - "repository": "", 22:28:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 22:28:52 INFO - "buildid": "20151110205155", 22:28:52 INFO - "slavename": "talos-linux64-ix-034", 22:28:52 INFO - "pgo_build": "True", 22:28:52 INFO - "basedir": "/builds/slave/test-pgo", 22:28:52 INFO - "project": "", 22:28:52 INFO - "platform": "ubuntu64_hw", 22:28:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:28:52 INFO - "slavebuilddir": "test", 22:28:52 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:28:52 INFO - "branch": "mozilla-inbound", 22:28:52 INFO - "repo_path": "integration/mozilla-inbound", 22:28:52 INFO - "stage_platform": "linux64-pgo", 22:28:52 INFO - "builduid": "754f5f87d4744965bcfbf2e2d79c8255", 22:28:52 INFO - "revision": "5ce07357c5f7" 22:28:52 INFO - }, 22:28:52 INFO - "sourcestamp": { 22:28:52 INFO - "repository": "", 22:28:52 INFO - "hasPatch": false, 22:28:52 INFO - "project": "", 22:28:52 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 22:28:52 INFO - "changes": [ 22:28:52 INFO - { 22:28:52 INFO - "category": null, 22:28:52 INFO - "files": [ 22:28:52 INFO - { 22:28:52 INFO - "url": null, 22:28:52 INFO - "name": "https://queue.taskcluster.net/v1/task/5P9uH1O7RN21C9C5dVrOYA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 22:28:52 INFO - } 22:28:52 INFO - ], 22:28:52 INFO - "repository": "", 22:28:52 INFO - "rev": "5ce07357c5f7", 22:28:52 INFO - "who": "sendchange", 22:28:52 INFO - "when": 1447223288, 22:28:52 INFO - "number": 6646453, 22:28:52 INFO - "comments": "", 22:28:52 INFO - "project": "", 22:28:52 INFO - "at": "Tue 10 Nov 2015 22:28:08", 22:28:52 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 22:28:52 INFO - "revlink": "", 22:28:52 INFO - "properties": [ 22:28:52 INFO - [ 22:28:52 INFO - "buildid", 22:28:52 INFO - "20151110205155", 22:28:52 INFO - "Change" 22:28:52 INFO - ], 22:28:52 INFO - [ 22:28:52 INFO - "builduid", 22:28:52 INFO - "754f5f87d4744965bcfbf2e2d79c8255", 22:28:52 INFO - "Change" 22:28:52 INFO - ], 22:28:52 INFO - [ 22:28:52 INFO - "pgo_build", 22:28:52 INFO - "True", 22:28:52 INFO - "Change" 22:28:52 INFO - ] 22:28:52 INFO - ], 22:28:52 INFO - "revision": "5ce07357c5f7" 22:28:52 INFO - } 22:28:52 INFO - ], 22:28:52 INFO - "revision": "5ce07357c5f7" 22:28:52 INFO - } 22:28:52 INFO - } 22:28:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/5P9uH1O7RN21C9C5dVrOYA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 22:28:52 INFO - Running post-action listener: _resource_record_post_action 22:28:52 INFO - ##### 22:28:52 INFO - ##### Running download-and-extract step. 22:28:52 INFO - ##### 22:28:52 INFO - Running pre-action listener: _resource_record_pre_action 22:28:52 INFO - Running main action method: download_and_extract 22:28:52 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:28:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:52 INFO - https://queue.taskcluster.net/v1/task/5P9uH1O7RN21C9C5dVrOYA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:28:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5P9uH1O7RN21C9C5dVrOYA/artifacts/public/build/test_packages.json 22:28:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5P9uH1O7RN21C9C5dVrOYA/artifacts/public/build/test_packages.json 22:28:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5P9uH1O7RN21C9C5dVrOYA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:28:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5P9uH1O7RN21C9C5dVrOYA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:28:54 INFO - Downloaded 1302 bytes. 22:28:54 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:28:54 INFO - Using the following test package requirements: 22:28:54 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:28:54 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:28:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:28:54 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:28:54 INFO - u'jsshell-linux-x86_64.zip'], 22:28:54 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:28:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:28:54 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:28:54 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:28:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:28:54 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:28:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:28:54 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:28:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:28:54 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:28:54 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:28:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:28:54 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:28:54 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:28:54 INFO - https://queue.taskcluster.net/v1/task/5P9uH1O7RN21C9C5dVrOYA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:28:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5P9uH1O7RN21C9C5dVrOYA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:28:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5P9uH1O7RN21C9C5dVrOYA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:28:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5P9uH1O7RN21C9C5dVrOYA/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:28:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5P9uH1O7RN21C9C5dVrOYA/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:28:58 INFO - Downloaded 22427781 bytes. 22:28: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:28:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:28: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:28:59 INFO - Return code: 0 22:28: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:28: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:28:59 INFO - https://queue.taskcluster.net/v1/task/5P9uH1O7RN21C9C5dVrOYA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:28:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5P9uH1O7RN21C9C5dVrOYA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:28:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5P9uH1O7RN21C9C5dVrOYA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:28:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5P9uH1O7RN21C9C5dVrOYA/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:28:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5P9uH1O7RN21C9C5dVrOYA/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:29:01 INFO - Downloaded 22427781 bytes. 22:29: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:29:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:29: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:29:02 INFO - Return code: 0 22:29: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:29:02 INFO - https://queue.taskcluster.net/v1/task/5P9uH1O7RN21C9C5dVrOYA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:29:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5P9uH1O7RN21C9C5dVrOYA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:29:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5P9uH1O7RN21C9C5dVrOYA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:29:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5P9uH1O7RN21C9C5dVrOYA/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:29:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5P9uH1O7RN21C9C5dVrOYA/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:29:03 INFO - Downloaded 11131693 bytes. 22:29: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:29:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:29: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:29:03 INFO - Return code: 0 22:29: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:29:03 INFO - https://queue.taskcluster.net/v1/task/5P9uH1O7RN21C9C5dVrOYA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:29:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5P9uH1O7RN21C9C5dVrOYA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:29:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5P9uH1O7RN21C9C5dVrOYA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:29:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5P9uH1O7RN21C9C5dVrOYA/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:29:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5P9uH1O7RN21C9C5dVrOYA/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:29:05 INFO - Downloaded 57139513 bytes. 22:29:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/5P9uH1O7RN21C9C5dVrOYA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:29:05 INFO - mkdir: /builds/slave/test-pgo/properties 22:29:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:29:05 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:29:05 INFO - Contents: 22:29:05 INFO - build_url:https://queue.taskcluster.net/v1/task/5P9uH1O7RN21C9C5dVrOYA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:29:05 INFO - Running post-action listener: _resource_record_post_action 22:29:05 INFO - Running post-action listener: set_extra_try_arguments 22:29:05 INFO - ##### 22:29:05 INFO - ##### Running populate-webroot step. 22:29:05 INFO - ##### 22:29:05 INFO - Running pre-action listener: _resource_record_pre_action 22:29:05 INFO - Running main action method: populate_webroot 22:29:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:29:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:29:05 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 22:29:05 INFO - '../fennec_ids.txt'], 22:29:05 INFO - 'tests': ['tcheck2']}, 22:29:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:29:05 INFO - '--tppagecycles', 22:29:05 INFO - '7'], 22:29:05 INFO - 'tests': ['tsvgm']}}, 22:29:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:29:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:29:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:29:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:29:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:29:05 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:29:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:29:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:05 INFO - 'talos_options': ['--e10s'], 22:29:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:29:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:05 INFO - 'tests': ['damp', 'tps']}, 22:29:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:05 INFO - 'talos_options': ['--e10s'], 22:29:05 INFO - 'tests': ['damp', 'tps']}, 22:29:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:29:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:29:05 INFO - 'other': {'tests': ['a11yr', 22:29:05 INFO - 'ts_paint', 22:29:05 INFO - 'tpaint', 22:29:05 INFO - 'sessionrestore', 22:29:05 INFO - 'sessionrestore_no_auto_restore']}, 22:29:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:29:05 INFO - 'tests': ['a11yr', 22:29:05 INFO - 'ts_paint', 22:29:05 INFO - 'tpaint', 22:29:05 INFO - 'sessionrestore', 22:29:05 INFO - 'sessionrestore_no_auto_restore']}, 22:29:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:29:05 INFO - 'tests': ['a11yr', 22:29:05 INFO - 'ts_paint', 22:29:05 INFO - 'tpaint', 22:29:05 INFO - 'sessionrestore', 22:29:05 INFO - 'sessionrestore_no_auto_restore']}, 22:29:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:29:05 INFO - 'tests': ['a11yr', 22:29:05 INFO - 'ts_paint', 22:29:05 INFO - 'tpaint', 22:29:05 INFO - 'sessionrestore', 22:29:05 INFO - 'sessionrestore_no_auto_restore']}, 22:29:05 INFO - 'other_l64': {'tests': ['a11yr', 22:29:05 INFO - 'ts_paint', 22:29:05 INFO - 'tpaint', 22:29:05 INFO - 'sessionrestore', 22:29:05 INFO - 'sessionrestore_no_auto_restore']}, 22:29:05 INFO - 'other_nol64': {'tests': ['a11yr', 22:29:05 INFO - 'ts_paint', 22:29:05 INFO - 'tpaint', 22:29:05 INFO - 'sessionrestore', 22:29:05 INFO - 'sessionrestore_no_auto_restore']}, 22:29:05 INFO - 'svgr': {'tests': ['tsvgx', 22:29:05 INFO - 'tsvgr_opacity', 22:29:05 INFO - 'tart', 22:29:05 INFO - 'tscrollx', 22:29:05 INFO - 'cart']}, 22:29:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:29:05 INFO - 'tests': ['tsvgx', 22:29:05 INFO - 'tsvgr_opacity', 22:29:05 INFO - 'tart', 22:29:05 INFO - 'tscrollx', 22:29:05 INFO - 'cart']}, 22:29:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:05 INFO - 'tests': ['tp5o']}, 22:29:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:05 INFO - 'talos_options': ['--e10s'], 22:29:05 INFO - 'tests': ['tp5o']}, 22:29:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:05 INFO - 'talos_options': ['--xperf_path', 22:29:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:29:05 INFO - 'tests': ['tp5n']}, 22:29:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:05 INFO - 'talos_options': ['--e10s', 22:29:05 INFO - '--xperf_path', 22:29:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:29:05 INFO - 'tests': ['tp5n']}}, 22:29:05 INFO - 'talos.zip': {'path': '', 22:29:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:29:05 INFO - Running post-action listener: _resource_record_post_action 22:29:05 INFO - ##### 22:29:05 INFO - ##### Running create-virtualenv step. 22:29:05 INFO - ##### 22:29:05 INFO - Running pre-action listener: _resource_record_pre_action 22:29:05 INFO - Running main action method: create_virtualenv 22:29:05 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:29: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:29:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:29:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:29:05 INFO - Using real prefix '/usr' 22:29:05 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:29:05 INFO - Installing distribute.............................................................................................................................................................................................done. 22:29:07 INFO - Installing pip.................done. 22:29:07 INFO - Return code: 0 22:29:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:29:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:29:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:29:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff411933c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c33d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124c8c0>, '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 0x11f9420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f98b0>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1447222890.726413-970869175', '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:29:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 22:29:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:29:07 INFO - Using env: {'DISPLAY': ':0', 22:29:07 INFO - 'HOME': '/home/cltbld', 22:29:07 INFO - 'LANG': 'en_US.UTF-8', 22:29:07 INFO - 'LANGUAGE': 'en_US:en', 22:29:07 INFO - 'LOGNAME': 'cltbld', 22:29:07 INFO - 'MAIL': '/var/mail/cltbld', 22:29:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:07 INFO - 'MOZ_NO_REMOTE': '1', 22:29:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:29:07 INFO - 'NO_EM_RESTART': '1', 22:29:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:29:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:29:07 INFO - 'PWD': '/builds/slave/test-pgo', 22:29:07 INFO - 'SHELL': '/bin/bash', 22:29:07 INFO - 'SHLVL': '1', 22:29:07 INFO - 'TERM': 'linux', 22:29:07 INFO - 'TMOUT': '86400', 22:29:07 INFO - 'USER': 'cltbld', 22:29:07 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1447222890.726413-970869175', 22:29:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:07 INFO - '_': '/tools/buildbot/bin/python'} 22:29:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:29:08 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:29:08 INFO - Cleaning up... 22:29:08 INFO - Return code: 0 22:29:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:29: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:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:29:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29: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:29:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:29:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29: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', '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 0x7ff411933c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c33d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124c8c0>, '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 0x11f9420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f98b0>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1447222890.726413-970869175', '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:29: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 22:29: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 psutil>=0.7.1 22:29:08 INFO - Using env: {'DISPLAY': ':0', 22:29:08 INFO - 'HOME': '/home/cltbld', 22:29:08 INFO - 'LANG': 'en_US.UTF-8', 22:29:08 INFO - 'LANGUAGE': 'en_US:en', 22:29:08 INFO - 'LOGNAME': 'cltbld', 22:29:08 INFO - 'MAIL': '/var/mail/cltbld', 22:29:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:08 INFO - 'MOZ_NO_REMOTE': '1', 22:29:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:29:08 INFO - 'NO_EM_RESTART': '1', 22:29:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:29:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:29:08 INFO - 'PWD': '/builds/slave/test-pgo', 22:29:08 INFO - 'SHELL': '/bin/bash', 22:29:08 INFO - 'SHLVL': '1', 22:29:08 INFO - 'TERM': 'linux', 22:29:08 INFO - 'TMOUT': '86400', 22:29:08 INFO - 'USER': 'cltbld', 22:29:08 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1447222890.726413-970869175', 22:29:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:08 INFO - '_': '/tools/buildbot/bin/python'} 22:29:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:29:08 INFO - Downloading/unpacking psutil>=0.7.1 22:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:09 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:29:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:29:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:29:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:29:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:29:10 INFO - Installing collected packages: psutil 22:29:10 INFO - Running setup.py install for psutil 22:29:10 INFO - building 'psutil._psutil_linux' extension 22:29:10 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:29:10 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:29:10 INFO - building 'psutil._psutil_posix' extension 22:29:10 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:29:10 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:29:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:29:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:29:10 INFO - Successfully installed psutil 22:29:10 INFO - Cleaning up... 22:29:10 INFO - Return code: 0 22:29:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:29:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:29:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:10 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 0x7ff411933c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c33d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124c8c0>, '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 0x11f9420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f98b0>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1447222890.726413-970869175', '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:29:10 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:29:10 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:29:10 INFO - Using env: {'DISPLAY': ':0', 22:29:10 INFO - 'HOME': '/home/cltbld', 22:29:10 INFO - 'LANG': 'en_US.UTF-8', 22:29:10 INFO - 'LANGUAGE': 'en_US:en', 22:29:10 INFO - 'LOGNAME': 'cltbld', 22:29:10 INFO - 'MAIL': '/var/mail/cltbld', 22:29:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:10 INFO - 'MOZ_NO_REMOTE': '1', 22:29:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:29:10 INFO - 'NO_EM_RESTART': '1', 22:29:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:29:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:29:10 INFO - 'PWD': '/builds/slave/test-pgo', 22:29:10 INFO - 'SHELL': '/bin/bash', 22:29:10 INFO - 'SHLVL': '1', 22:29:10 INFO - 'TERM': 'linux', 22:29:10 INFO - 'TMOUT': '86400', 22:29:10 INFO - 'USER': 'cltbld', 22:29:10 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1447222890.726413-970869175', 22:29:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:10 INFO - '_': '/tools/buildbot/bin/python'} 22:29:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:29:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:29: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:29: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:29: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:29: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:29: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:29: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:29:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:29:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:29:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:29:12 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:29:12 INFO - Installing collected packages: mozsystemmonitor 22:29:12 INFO - Running setup.py install for mozsystemmonitor 22:29:12 INFO - Successfully installed mozsystemmonitor 22:29:12 INFO - Cleaning up... 22:29:12 INFO - Return code: 0 22:29:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:29:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:29:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7ff411933c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c33d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124c8c0>, '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 0x11f9420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f98b0>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1447222890.726413-970869175', '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:29:12 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:29:12 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:29:12 INFO - Using env: {'DISPLAY': ':0', 22:29:12 INFO - 'HOME': '/home/cltbld', 22:29:12 INFO - 'LANG': 'en_US.UTF-8', 22:29:12 INFO - 'LANGUAGE': 'en_US:en', 22:29:12 INFO - 'LOGNAME': 'cltbld', 22:29:12 INFO - 'MAIL': '/var/mail/cltbld', 22:29:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:12 INFO - 'MOZ_NO_REMOTE': '1', 22:29:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:29:12 INFO - 'NO_EM_RESTART': '1', 22:29:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:29:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:29:12 INFO - 'PWD': '/builds/slave/test-pgo', 22:29:12 INFO - 'SHELL': '/bin/bash', 22:29:12 INFO - 'SHLVL': '1', 22:29:12 INFO - 'TERM': 'linux', 22:29:12 INFO - 'TMOUT': '86400', 22:29:12 INFO - 'USER': 'cltbld', 22:29:12 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1447222890.726413-970869175', 22:29:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:12 INFO - '_': '/tools/buildbot/bin/python'} 22:29:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:29:12 INFO - Downloading/unpacking blobuploader==1.2.4 22:29:12 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:29:12 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:29:12 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:29:12 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:29:12 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:29:12 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:29:14 INFO - Downloading blobuploader-1.2.4.tar.gz 22:29:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:29:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:29:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:29: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:29: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:29: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:29: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:29: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:29: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:29:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:29:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:29:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:15 INFO - Downloading docopt-0.6.1.tar.gz 22:29:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:29:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:29:15 INFO - Installing collected packages: blobuploader, requests, docopt 22:29:15 INFO - Running setup.py install for blobuploader 22:29:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:29:15 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:29:15 INFO - Running setup.py install for requests 22:29:15 INFO - Running setup.py install for docopt 22:29:15 INFO - Successfully installed blobuploader requests docopt 22:29:15 INFO - Cleaning up... 22:29:15 INFO - Return code: 0 22:29:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:29:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:29:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:29:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:15 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 0x7ff411933c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c33d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124c8c0>, '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 0x11f9420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f98b0>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1447222890.726413-970869175', '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:29:15 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:29:15 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:29:15 INFO - Using env: {'DISPLAY': ':0', 22:29:15 INFO - 'HOME': '/home/cltbld', 22:29:15 INFO - 'LANG': 'en_US.UTF-8', 22:29:15 INFO - 'LANGUAGE': 'en_US:en', 22:29:15 INFO - 'LOGNAME': 'cltbld', 22:29:15 INFO - 'MAIL': '/var/mail/cltbld', 22:29:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:15 INFO - 'MOZ_NO_REMOTE': '1', 22:29:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:29:15 INFO - 'NO_EM_RESTART': '1', 22:29:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:29:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:29:15 INFO - 'PWD': '/builds/slave/test-pgo', 22:29:15 INFO - 'SHELL': '/bin/bash', 22:29:15 INFO - 'SHLVL': '1', 22:29:15 INFO - 'TERM': 'linux', 22:29:15 INFO - 'TMOUT': '86400', 22:29:15 INFO - 'USER': 'cltbld', 22:29:15 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1447222890.726413-970869175', 22:29:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:15 INFO - '_': '/tools/buildbot/bin/python'} 22:29:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:29:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:29:16 INFO - Running setup.py (path:/tmp/pip-jcyUFf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:29:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:29:16 INFO - Running setup.py (path:/tmp/pip-UMUuP0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:29:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:29:16 INFO - Running setup.py (path:/tmp/pip-YgrBz3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:29:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:29:16 INFO - Running setup.py (path:/tmp/pip-e024fR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:29:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:29:16 INFO - Running setup.py (path:/tmp/pip-6Fu6Ba-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:29:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:29:16 INFO - Running setup.py (path:/tmp/pip-ROZfEf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:29:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:29:16 INFO - Running setup.py (path:/tmp/pip-Ql7EB7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:29:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:29:16 INFO - Running setup.py (path:/tmp/pip-5xlqn1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:29:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:29:16 INFO - Running setup.py (path:/tmp/pip-tUAYBT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:29:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:29:16 INFO - Running setup.py (path:/tmp/pip-fk9ZoR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:29:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:29:16 INFO - Running setup.py (path:/tmp/pip-sHBrcS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:29:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:29:16 INFO - Running setup.py (path:/tmp/pip-iPRa4I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:29:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:29:16 INFO - Running setup.py (path:/tmp/pip-gPxZeC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:29:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:29:17 INFO - Running setup.py (path:/tmp/pip-rtFBOd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:29:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:29:17 INFO - Running setup.py (path:/tmp/pip-uTNm5d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:29:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:29:17 INFO - Running setup.py (path:/tmp/pip-Y3mA_Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:29:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:29:17 INFO - Running setup.py (path:/tmp/pip-xTd_Iw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:29:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:29:17 INFO - Running setup.py install for manifestparser 22:29:17 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:29:17 INFO - Running setup.py install for mozcrash 22:29:17 INFO - Running setup.py install for mozdebug 22:29:17 INFO - Running setup.py install for mozdevice 22:29:17 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:29:17 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:29:17 INFO - Running setup.py install for mozfile 22:29:17 INFO - Running setup.py install for mozhttpd 22:29:17 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:29:17 INFO - Running setup.py install for mozinfo 22:29:18 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:29:18 INFO - Running setup.py install for mozInstall 22:29:18 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:29:18 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:29:18 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:29:18 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:29:18 INFO - Running setup.py install for mozleak 22:29:18 INFO - Running setup.py install for mozlog 22:29:18 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:29:18 INFO - Running setup.py install for moznetwork 22:29:18 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:29:18 INFO - Running setup.py install for mozprocess 22:29:18 INFO - Running setup.py install for mozprofile 22:29:18 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:29:18 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:29:18 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:29:18 INFO - Running setup.py install for mozrunner 22:29:18 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:29:18 INFO - Running setup.py install for mozscreenshot 22:29:18 INFO - Running setup.py install for moztest 22:29:19 INFO - Running setup.py install for mozversion 22:29:19 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:29:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:29:19 INFO - Cleaning up... 22:29:19 INFO - Return code: 0 22:29:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:29: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:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:29:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29: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:29:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:29:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:19 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 0x7ff411933c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c33d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124c8c0>, '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 0x11f9420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f98b0>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1447222890.726413-970869175', '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:29:19 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:29:19 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:29:19 INFO - Using env: {'DISPLAY': ':0', 22:29:19 INFO - 'HOME': '/home/cltbld', 22:29:19 INFO - 'LANG': 'en_US.UTF-8', 22:29:19 INFO - 'LANGUAGE': 'en_US:en', 22:29:19 INFO - 'LOGNAME': 'cltbld', 22:29:19 INFO - 'MAIL': '/var/mail/cltbld', 22:29:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:19 INFO - 'MOZ_NO_REMOTE': '1', 22:29:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:29:19 INFO - 'NO_EM_RESTART': '1', 22:29:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:29:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:29:19 INFO - 'PWD': '/builds/slave/test-pgo', 22:29:19 INFO - 'SHELL': '/bin/bash', 22:29:19 INFO - 'SHLVL': '1', 22:29:19 INFO - 'TERM': 'linux', 22:29:19 INFO - 'TMOUT': '86400', 22:29:19 INFO - 'USER': 'cltbld', 22:29:19 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1447222890.726413-970869175', 22:29:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:19 INFO - '_': '/tools/buildbot/bin/python'} 22:29:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:29:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:29:19 INFO - Running setup.py (path:/tmp/pip-LVwP83-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:29:19 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:29:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:29:19 INFO - Running setup.py (path:/tmp/pip-y618iG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:29:19 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:29:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:29:19 INFO - Running setup.py (path:/tmp/pip-V5vFRa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:29:19 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:29:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:29:19 INFO - Running setup.py (path:/tmp/pip-yzkvZs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:29:19 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:29:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:29:19 INFO - Running setup.py (path:/tmp/pip-d4sO8k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:29:19 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:29:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:29:19 INFO - Running setup.py (path:/tmp/pip-sTlqJ2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:29:19 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:29:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:29:19 INFO - Running setup.py (path:/tmp/pip-U10Ipc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:29:19 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:29:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:29:19 INFO - Running setup.py (path:/tmp/pip-Eredqj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:29:19 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:29:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:29:19 INFO - Running setup.py (path:/tmp/pip-r6iwhv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:29:19 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:29:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:29:20 INFO - Running setup.py (path:/tmp/pip-r_swtv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:29:20 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:29:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:29:20 INFO - Running setup.py (path:/tmp/pip-NmVIJO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:29:20 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:29:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:29:20 INFO - Running setup.py (path:/tmp/pip-NOi_ce-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:29:20 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:29:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:29:20 INFO - Running setup.py (path:/tmp/pip-WbLjil-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:29:20 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:29:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:29:20 INFO - Running setup.py (path:/tmp/pip-GPPNZH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:29:20 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:29:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:29:20 INFO - Running setup.py (path:/tmp/pip-9wQYde-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:29:20 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:29:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:29:20 INFO - Running setup.py (path:/tmp/pip-2SSFli-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:29:20 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:29:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:29:20 INFO - Running setup.py (path:/tmp/pip-v2R32R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:29:20 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:29:20 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:29:20 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:29:20 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:29:20 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:29:20 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:29:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:22 INFO - Downloading blessings-1.5.1.tar.gz 22:29:22 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:29:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:29:22 INFO - Installing collected packages: blessings 22:29:22 INFO - Running setup.py install for blessings 22:29:22 INFO - Successfully installed blessings 22:29:22 INFO - Cleaning up... 22:29:22 INFO - Return code: 0 22:29:22 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:29:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:29:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:29:22 INFO - Reading from file tmpfile_stdout 22:29:22 INFO - Current package versions: 22:29:22 INFO - argparse == 1.2.1 22:29:22 INFO - blessings == 1.5.1 22:29:22 INFO - blobuploader == 1.2.4 22:29:22 INFO - docopt == 0.6.1 22:29:22 INFO - manifestparser == 1.1 22:29:22 INFO - mozInstall == 1.12 22:29:22 INFO - mozcrash == 0.16 22:29:22 INFO - mozdebug == 0.1 22:29:22 INFO - mozdevice == 0.47 22:29:22 INFO - mozfile == 1.2 22:29:22 INFO - mozhttpd == 0.7 22:29:22 INFO - mozinfo == 0.9 22:29:22 INFO - mozleak == 0.1 22:29:22 INFO - mozlog == 3.0 22:29:22 INFO - moznetwork == 0.27 22:29:22 INFO - mozprocess == 0.22 22:29:22 INFO - mozprofile == 0.27 22:29:22 INFO - mozrunner == 6.11 22:29:22 INFO - mozscreenshot == 0.1 22:29:22 INFO - mozsystemmonitor == 0.0 22:29:22 INFO - moztest == 0.7 22:29:22 INFO - mozversion == 1.4 22:29:22 INFO - psutil == 3.1.1 22:29:22 INFO - requests == 1.2.3 22:29:22 INFO - wsgiref == 0.1.2 22:29:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:29: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:29:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:29:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29: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:29:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:29:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29: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/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 0x7ff411933c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c33d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124c8c0>, '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 0x11f9420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f98b0>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1447222890.726413-970869175', '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:29: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/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:29: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/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:29:22 INFO - Using env: {'DISPLAY': ':0', 22:29:22 INFO - 'HOME': '/home/cltbld', 22:29:22 INFO - 'LANG': 'en_US.UTF-8', 22:29:22 INFO - 'LANGUAGE': 'en_US:en', 22:29:22 INFO - 'LOGNAME': 'cltbld', 22:29:22 INFO - 'MAIL': '/var/mail/cltbld', 22:29:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:22 INFO - 'MOZ_NO_REMOTE': '1', 22:29:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:29:22 INFO - 'NO_EM_RESTART': '1', 22:29:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:29:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:29:22 INFO - 'PWD': '/builds/slave/test-pgo', 22:29:22 INFO - 'SHELL': '/bin/bash', 22:29:22 INFO - 'SHLVL': '1', 22:29:22 INFO - 'TERM': 'linux', 22:29:22 INFO - 'TMOUT': '86400', 22:29:22 INFO - 'USER': 'cltbld', 22:29:22 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1447222890.726413-970869175', 22:29:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:22 INFO - '_': '/tools/buildbot/bin/python'} 22:29:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:29:22 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:29:22 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:29:22 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:29:22 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:29:22 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:29:22 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:29:22 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:29:22 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:29:22 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:29:22 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:29:22 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:29:22 INFO - Cleaning up... 22:29:22 INFO - Return code: 0 22:29:22 INFO - Running post-action listener: _resource_record_post_action 22:29:22 INFO - Running post-action listener: _start_resource_monitoring 22:29:22 INFO - Starting resource monitoring. 22:29:22 INFO - ##### 22:29:22 INFO - ##### Running install step. 22:29:22 INFO - ##### 22:29:22 INFO - Running pre-action listener: _resource_record_pre_action 22:29:22 INFO - Running main action method: install 22:29:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:29:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:29:23 INFO - Reading from file tmpfile_stdout 22:29:23 INFO - Detecting whether we're running mozinstall >=1.0... 22:29:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:29:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:29:23 INFO - Reading from file tmpfile_stdout 22:29:23 INFO - Output received: 22:29:23 INFO - Usage: mozinstall [options] installer 22:29:23 INFO - Options: 22:29:23 INFO - -h, --help show this help message and exit 22:29:23 INFO - -d DEST, --destination=DEST 22:29:23 INFO - Directory to install application into. [default: 22:29:23 INFO - "/builds/slave/test-pgo"] 22:29:23 INFO - --app=APP Application being installed. [default: firefox] 22:29:23 INFO - mkdir: /builds/slave/test-pgo/build/application 22:29:23 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:29:23 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:29:37 INFO - Reading from file tmpfile_stdout 22:29:37 INFO - Output received: 22:29:37 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:29:37 INFO - Running post-action listener: _resource_record_post_action 22:29:37 INFO - ##### 22:29:37 INFO - ##### Running run-tests step. 22:29:37 INFO - ##### 22:29:37 INFO - Running pre-action listener: _resource_record_pre_action 22:29:37 INFO - Running main action method: run_tests 22:29:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:29:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:29:37 INFO - Python 2.7.3 22:29:37 INFO - Return code: 0 22:29:37 INFO - grabbing minidump binary from tooltool 22:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:37 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 0x124c8c0>, '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 0x11f9420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f98b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:29:37 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:29:37 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:29:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:29:37 INFO - Return code: 0 22:29:37 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:29:37 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:29:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:29:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:29:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:29:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/5P9uH1O7RN21C9C5dVrOYA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 22:29:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/5P9uH1O7RN21C9C5dVrOYA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost 22:29:37 INFO - Using env: {'DISPLAY': ':0', 22:29:37 INFO - 'HOME': '/home/cltbld', 22:29:37 INFO - 'LANG': 'en_US.UTF-8', 22:29:37 INFO - 'LANGUAGE': 'en_US:en', 22:29:37 INFO - 'LOGNAME': 'cltbld', 22:29:37 INFO - 'MAIL': '/var/mail/cltbld', 22:29:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:29:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:29:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:37 INFO - 'MOZ_NO_REMOTE': '1', 22:29:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:29:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:29:37 INFO - 'NO_EM_RESTART': '1', 22:29:37 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:29:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:29:37 INFO - 'PWD': '/builds/slave/test-pgo', 22:29:37 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:29:37 INFO - 'SHELL': '/bin/bash', 22:29:37 INFO - 'SHLVL': '1', 22:29:37 INFO - 'TERM': 'linux', 22:29:37 INFO - 'TMOUT': '86400', 22:29:37 INFO - 'USER': 'cltbld', 22:29:37 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1447222890.726413-970869175', 22:29:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:37 INFO - '_': '/tools/buildbot/bin/python'} 22:29:37 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/5P9uH1O7RN21C9C5dVrOYA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost'] with output_timeout 3600 22:29:37 INFO - mozversion INFO | application_buildid: 20151110205155 22:29:37 INFO - mozversion INFO | application_changeset: 5ce07357c5f7e458b0b5cfe1daad8e8eb772f765 22:29:37 INFO - mozversion INFO | application_display_name: Nightly 22:29:37 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:29:37 INFO - mozversion INFO | application_name: Firefox 22:29:37 INFO - mozversion INFO | application_remotingname: firefox 22:29:37 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:29:37 INFO - mozversion INFO | application_vendor: Mozilla 22:29:37 INFO - mozversion INFO | application_version: 45.0a1 22:29:37 INFO - mozversion INFO | platform_buildid: 20151110205155 22:29:37 INFO - mozversion INFO | platform_changeset: 5ce07357c5f7e458b0b5cfe1daad8e8eb772f765 22:29:37 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:29:37 INFO - mozversion INFO | platform_version: 45.0a1 22:29:37 INFO - 2015-11-10 22:29:37,895 DEBUG : using testdate: 1447223377 22:29:37 INFO - 2015-11-10 22:29:37,895 DEBUG : actual date: 1447223377 22:29:37 INFO - 2015-11-10 22:29:37,904 INFO : starting webserver on 'localhost:32960' 22:29:37 INFO - 2015-11-10 22:29:37,905 INFO : Starting test suite talos-linux64-ix-034 22:29:37 INFO - 2015-11-10 22:29:37,905 INFO : Starting test dromaeo_css 22:29:37 INFO - 2015-11-10 22:29:37,905 DEBUG : operating with platform_type : linux_ 22:29:37 INFO - 2015-11-10 22:29:37,906 INFO : Initialising browser for dromaeo_css test... 22:29:37 INFO - 2015-11-10 22:29:37,920 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHLf3d1/profile http://localhost:32960/getInfo.html 22:29:42 INFO - 2015-11-10 22:29:42,370 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:29:42 INFO - 2015-11-10 22:29:42,370 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:29:42 INFO - 2015-11-10 22:29:42,370 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:29:42 INFO - 2015-11-10 22:29:42,370 DEBUG : BROWSER_OUTPUT: __metrics 22:29:42 INFO - 2015-11-10 22:29:42,499 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:29:43 INFO - 2015-11-10 22:29:43,891 INFO : Browser initialized. 22:29:43 INFO - 2015-11-10 22:29:43,892 INFO : Running cycle 1/1 for dromaeo_css test... 22:29:43 INFO - 2015-11-10 22:29:43,892 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHLf3d1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:29:55 INFO - 2015-11-10 22:29:55,648 DEBUG : BROWSER_OUTPUT: RSS: Main: 141144064 22:29:55 INFO - 2015-11-10 22:29:55,648 DEBUG : BROWSER_OUTPUT: 22:30:46 INFO - 2015-11-10 22:30:46,337 DEBUG : BROWSER_OUTPUT: 1447223446334 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:32:55 INFO - 2015-11-10 22:32:55,749 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32960/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32960/tests/dromaeo/cssquery-ext.html) 22:32:56 INFO - 2015-11-10 22:32:56,855 DEBUG : BROWSER_OUTPUT: RSS: Main: 221495296 22:32:56 INFO - 2015-11-10 22:32:56,855 DEBUG : BROWSER_OUTPUT: 22:35:59 INFO - 2015-11-10 22:35:59,219 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32960/tests/dromaeo/cssquery-ext.html (next: http://localhost:32960/tests/dromaeo/cssquery-jquery.html) 22:35:59 INFO - 2015-11-10 22:35:59,784 DEBUG : BROWSER_OUTPUT: RSS: Main: 216965120 22:35:59 INFO - 2015-11-10 22:35:59,784 DEBUG : BROWSER_OUTPUT: 22:39:01 INFO - 2015-11-10 22:39:01,731 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32960/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32960/tests/dromaeo/cssquery-mootools.html) 22:39:02 INFO - 2015-11-10 22:39:02,304 DEBUG : BROWSER_OUTPUT: RSS: Main: 207683584 22:39:02 INFO - 2015-11-10 22:39:02,305 DEBUG : BROWSER_OUTPUT: 22:42:04 INFO - 2015-11-10 22:42:04,065 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32960/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32960/tests/dromaeo/cssquery-prototype.html) 22:42:04 INFO - 2015-11-10 22:42:04,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 198574080 22:42:04 INFO - 2015-11-10 22:42:04,639 DEBUG : BROWSER_OUTPUT: 22:45:07 INFO - 2015-11-10 22:45:07,041 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32960/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32960/tests/dromaeo/cssquery-yui.html) 22:45:07 INFO - 2015-11-10 22:45:07,622 DEBUG : BROWSER_OUTPUT: RSS: Main: 199880704 22:45:07 INFO - 2015-11-10 22:45:07,623 DEBUG : BROWSER_OUTPUT: 22:48:10 INFO - 2015-11-10 22:48:10,114 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32960/tests/dromaeo/cssquery-yui.html (next: http://localhost:32960/tests/dromaeo/cssquery-dojo.html) 22:48:10 INFO - 2015-11-10 22:48:10,364 DEBUG : BROWSER_OUTPUT: RSS: Main: 260255744 22:48:10 INFO - 2015-11-10 22:48:10,364 DEBUG : BROWSER_OUTPUT: 22:48:10 INFO - 2015-11-10 22:48:10,365 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:48:10 INFO - 2015-11-10 22:48:10,365 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:48:10 INFO - 2015-11-10 22:48:10,365 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:48:10 INFO - 2015-11-10 22:48:10,366 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:48:10 INFO - 2015-11-10 22:48:10,366 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3195.760317976152;3236.304194598164;3275.099347679388;3286.6384697683266;3290.5228741832434;5306.602004849642;5420.268263784388;5433.130699088147;5454.918176227355;5465.016297066526;5401.081816091264;5408.242846001563;5450.809221677232;5461.644993075447;5479.698616576086;4939.777710003059;4962.1812400953795;5047.419546752134;5115.360579927509;5154;4859;5074.746262686869;5110.1312776827845;5111.437741848394;5158.871028224287;4857.781399837016;4956.826511072095;4967.230079337708;4970.925436118443;4997.6501644884875;5038.521340472649;5062.67092638981;5068.898622027576;5076.670016448919;5116.027954688598;4814.253790662453;5026.5727413169925;5050.292958985745;5070.923936140961;5079.746012699387;5167.069927413064;5221.71280579568;5242.370915490127;5268.841934741964;5309.840704778863;5889.823305300848;5902.793402230945;5910.763569457216;5919.289685237756;5932.495737862287;5852.414758524156;5963.373845746221;5984;5986.3714309997695;5988.790392336247;5445.754941027663;5501.339839219319;5518.889622207534;5547.389787123413;5579.13523403873;6031.517478601701;6032.065029920369;6060.184379892085;6063.878722425527;6074.36219196978;5691.373948865621;5831.096180092092;5835.941640583625;5836.9124463133085;5898.498627616615;5806.187133801272;5877.970610147007;5880.647161170344;5906.970465147647;5912.793052243151;5841.1238314253205;5925.644461332334;5928.347881733006;5931.822045338647;5938.168656388109;5690.5447564194765;5807.767689292466;5916.674582897982;5924.555658325643;5925.674087925206;4402.097569998143;4472.239719247736;4489.663275254369;4500.4149460569915;4508.932366014513;4000.8399664013114;4011.5988401159652;4011.919761604752;4018.557958624549;4051.8987025324013;5396.325459317585;5574.693391863487;5575.107982722745;5576.247206627054;5583;5782.942170578241;5812.128180772918;5879.882402351929;5881.735321910524;5913.674747888907;5433;5556.472135147154;5602.327720673546;5606.355269144019;5621.269234999424;4839.177339852234;4915.926261106087;5083.847484575469;5098.337216161949;5139.12634852076;5955.434233747787;6058.666773327509;6068.059450785136;6069;6113.541484388688;5870.236869206976;5948.881022379442;5954.46409823118;5957.6127551709;5960.344362120077;5827.3007239131575;5940.435658612425;5981.312149102909;6100.389961003864;6140.263168419819;5802.187693722966;5802.65184088956;5803.912941305968;5814.156947242711;5849.298084229919;5852.18069470266;5875.50058245054;5877.823665290048;5879.2944846618675;5885.087811389241;5572.944270557405;5696;5702.572307076903;5746.655200687972;5833.183354330312;5781.682007489629;5807.970960145172;5808.5643576732755;5809.709514524341;5814.5348372130975;5700.116481945305;5704.971475142598;5708.714564271687;5718.685472299064;5728.140778883201;5609.467100625434;5718;5785.4214578541805;5907.2911250650195;5928.347881733092;5693.259876216065;5711.400302968129;5711.571632127524;5718;5728.541716662574 22:48:10 INFO - 2015-11-10 22:48:10,367 DEBUG : BROWSER_OUTPUT: |1;ext.html;560.2428676773384;579.0792639702872;599.4724642314764;601.8014055361731;627.2441707742171;31385.52921706176;39865.60134398655;40103.19793604133;40171.59828401715;40201.1959760805;43734;44487.110257794826;44510.10979780411;44538.77730611342;44544.554554454444;7653.961730191341;7746.728864489744;8692.869606955885;9006.279497640173;10273.794524109513;10415.062644362006;10461.320014199091;10519.894801052007;10525.736856578571;10526.736831579195;10491.73770655732;10521.473926303692;10564.524596393181;10583.629572964948;10588.311759735592;7861.960690196541;8050.677972881107;10578.682639520826;10804.243702940797;10832.40421776802;10370.585176592927;10485.37087774736;10491.790164196673;10508.369497830077;10509.106725928305;39716.40425393621;40079;40108.799456002824;40140;40240.19519609591;3032.605761251023;3047.6495203051713;3242.8864989725485;3399.5920489541168;3662.487251784752;30284.54573181404;30462.69537304643;30466.84766576175;30639.387212255853;31506.212344691336;3461.4769501419546;3488.3546543889206;3542.1321776164746;3558.893233202982;3691.9630803692157;289630;290985;291092;291545;291911;47843.76078119587;48394.27408588874;64694;65555.68888622201;65699.67150164218;60632;60811;60850;60894;61036.69481652652;12868.613941581767;12945;12952.546660867012;12971.41628626714;12984.545540906023;10869.782604347869;10909.563617455371;10928.672139835817;10938.507767150497;10957.945210274058;19148;19212;19331.226750929804;19462.902685486766;19488.415347539314;7524.435667324972;7715.884261736079;7767.572783496849;7791.532508049535;7795.727149549739;952.6808519146025;1035.761774791787;1040.2406243442329;1100.4772732951944;1118.0273162348647;28618;29007.70992290092;29245.26886827804;29407.85296073506;34064.1483962898;976.3946353260882;1042.358949246208;1062.6333914799382;1064.5528877871159;1186.7804456175636;15593.766093508606;15598.376064957502;15711.371545138296;15721.764173537405;15839.683206335809;388658;389638;394453;395629;395980;54500;55011.44988550143;55043.72478137584;55110.448895511334;55122.44877551253;1282.0961222338415;1327.084311824857;1384.9099808512415;1390.958271251864;1432.1621851216946;23254.53490930138;30857.382852343275;30968.53547196839;31194.532082019243;31321.530177047818;51083;51802.740986294826;51813;51876.740616298186;51902.74048629733;306528;307955;308624;391151;399203;32382.83808580942;32699;32809.83595082105;33062.17344566405;33200.1699957503;39252.62615808433;40064.59935400725;40418.1916361677;40616.593834061285;40741.1851762969;35972;36002.45996310005;36035.459468107474;36172;37336.253274933806;36226.275474489834;36619;36834;36858.8157059213;36917;40979.180416392104;40990;41150.58849411467;41474.58525414828;41679.58320416757;32423.513647295782;32450.83774581112;35309;35385.292294153456;35429;26373.208803735917;26470.86764566242;26554.867225663747;26564.203073907815;26889.865550672122 22:48:10 INFO - 2015-11-10 22:48:10,367 DEBUG : BROWSER_OUTPUT: |2;jquery.html;344.2340791738384;345.0838025043509;346.61525706465824;346.82485344900823;347.36085602491426;14395;14733.778993315082;16753.832461675378;17057.488275351727;18457.446276611707;14137.929310353435;15388.307526161321;15672.294746736396;15679.45121920733;15782.289796959136;5285.497877701622;5431.972840135813;5432.266644003068;5434.130539113743;5439.3200849893765;4023.1953609278116;4134.255833949888;5368.543673787733;5408.756605952742;5734.369219385864;5789.4500022498005;5805.941940580604;5814.680192589406;5821.563382746311;5822.505087067604;5783.6529808211435;5908.88182236355;5932.822015339503;5936.881262374772;5937.970310148443;5195;5197.402298735656;5204.609654275907;5207.791688332462;5208.218767184915;13518.188908665512;13946.86053139476;20846.583068338547;21668.674969875465;21728.13087476499;1943.3004118517322;2036.4399790057705;2062.092679221138;2140.2616097446357;2228.1198926424136;9857.96491368403;9913.553890074963;10009.849852252222;10104.393736375841;10124.69625911224;1665.4504013675457;1680.15992003998;1683.6716840216163;1701.897886126824;1773.7605423267823;52492.21261681078;56938;61150.388496114916;63183.6840815793;63320.36679633191;6795.7961261162245;6864.897026544606;6876.69054892521;6887.104676392037;6936;8491.575421228914;8543.786405339792;8551.700690475927;8557.614907329185;8561.871571926426;5593.636413633101;5612.915806262909;5613.045782216951;5645.9717701412055;5660.462256085665;5302.628815982845;5308.893822123536;5317.973410132925;5646.830595082154;5720.599558030898;3329.7502687298065;3357.4292370297107;3361.2605226850055;3378.6283508814013;3379.932401351959;1135.1940122512942;1149.2070471374725;1170.5317872850928;1202.1825158892038;1202.392791640216;448.59402240971974;494.0982706560541;496.5134168514876;498.551303826559;511.52428241735544;10808.297460665031;12223.205491643015;12376.938115309365;12570.68573285657;12606.684832879251;477.8661974647104;480.93507376504425;486.1104179351778;489.5593965431069;510.8595136337537;6567.704453299613;6576.539642225094;6683.832904177434;6990.266022067712;6992.440604751608;402959;457813;480183;520940;542271;73560;74364.62817685877;76076.61961690156;76515;77946;549.2118809508369;549.8872731090117;555.9610827242135;556.1102236421774;556.2851735519838;11190.160737944523;11386.146039046938;11412.144089193178;11540.422978851191;11548.94225528867;35076.66771656689;35240;35507.11232219112;36467.817660911525;36575.63424365722;47206.29190562213;47435;55569;55779;55953.72023140021;13795.379207935868;14591;15098;15111.54665360041;15182.46861359847;18161.545961351072;18551.072446377897;18621.44135675932;19072;19554.120064597413;9301;9606;11390.361314104355;16000.119993400474;16268.918655406647;9336.253099751868;9429.575669095044;9466.148046675833;9478.146966773023;9648.662296819859;9637.132658060807;9868.210543156387;10014.799704006025;10054.095131438205;10076.244281678757;14943.90785290082;15001.099934003994;15019;15283.388664453298;15327.540173794803;15752.684946301239;15775.29011194476;15961.44134955271;16080.67838643244;16309.59226019359 22:48:10 INFO - 2015-11-10 22:48:10,369 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1337.9464821407144;1681.352679218501;1731.800842903066;1756.3325936144263;1776.5647416382988;6266.686665666715;7477.663505142268;7619.657115429805;7623.809404764884;7653.4259930505295;7506.324430801227;7604.1635420103885;7606.353459955896;7611.657475413605;7611.77164685059;2238.7425446073667;2260.9886950565224;2263.366257447917;2264.286749673856;2265.3317271404976;2262.7284725832924;2280.441291883491;2292.9656055159185;2297.310806757974;2298.184144628658;2192.473806286496;2210.270610698474;2234.7876951689564;2243.674667173259;2249.7750224977535;2221.0227499899993;2260.0507786729613;2271.057511132878;2274.795268425841;2275.4425165834396;2209.2819833554;2216.213244298283;2219.8557093789013;2221.7000704904794;2223.7442694090223;6452.483801295885;6646.634435106067;7568.924310756877;7582.052243469567;7597.924020759777;4310.3534469829465;4400;4401.5598440156045;4404.4934832494355;4413.249747542925;2912.4320757452306;2998.175501737018;3029.4849875521213;3053.64883038449;3067.0952069139657;937.7374335186158;941.6515889121;982.4792859784326;1012.1953047327393;1016.207358260558;10417.427041512714;10488.895111048945;10489.842652360221;10490.370577765283;10501.894981050245;4100.753954762724;4174.686898482565;4180.749155050646;4184.66522678185;4222;8934.50860202695;8954.686585969459;8963.193312601767;8969.416987895765;8974.37179397449;4364.934525982113;4373.6282415994365;4392.648588112943;4402.361657559636;4407.294832826732;3882.320593896057;3907.0427745202037;3915.7454765440157;3916.373380259145;3922.3332033554366;3441.4493681010917;3493.8427770750377;3497.178163131662;3499.4750787382095;3518.7009104225917;1150.3500522205095;1153.3598852636867;1153.7404084081184;1157.3171828621155;1173.8532683414574;1302.4334414529521;1307.3463268365817;1328.5283724277742;1332.0209645910247;1341.5505805555053;7133.857322853514;7212.170600381023;7224.385927196247;7227.096612923385;7270.818229544304;456.50241237051773;468.02183436617634;469.85904228731243;470.8493282149679;474.5065132262408;5044.8234311798915;5594.524465420403;5638.4925356718095;5648.85877853057;5654.434556544395;7788.221177882167;8695.260902823331;8908.599113039929;8961.686340978034;9023.593938272794;8720.389572729975;8755.255803256667;8767.780805479786;8864.601092950832;8876.644934202688;6986;7117.857642847114;7159.176694680178;7160.641967901584;7163.212046674862;6730.730770769114;6850.417714494324;6870.62211578368;6878.69045892946;6897.827554311182;7848.254415830487;8037.236462536283;8070.515769053875;8072.87890681652;8073.031236251687;8127.593620319079;8186.222308880647;8261.917380826115;8342.165783421851;8356.331493480386;6724.8991265132045;6756;6765.797026089225;6787.490938179558;6805.9659701701175;7301.671424785791;7324.304191101837;7344.339009489172;7407.222241664763;7419.183889772229;6756.155480564929;6943.236244013256;7028.613426261605;7040;7149.571025738473;6901.033855260167;6923.792286231421;6976.4767642426;6980.336867997736;6983.650817459208;6927.168739751262;6988.965055174692;6993.965030174817;6997.370236678723;6999.370056694922;6476.514261430506;6494.058361537645;6494.1232933553365;6510.837229069121;6514.478841692748;6187.84530386744;6265.310815810166;6268.091126786499;6275.623462592259;6311.116443697978 22:48:10 INFO - 2015-11-10 22:48:10,370 DEBUG : BROWSER_OUTPUT: |4;prototype.html;294.27608084113086;295.23534046818736;298.9925251868704;299.3533966632074;301.8566181063994;5864.061750119981;5971.31329897062;5988.940110598893;6001.039833626621;6039.818805435833;5828.300603927534;5897.734601942912;5898.1447690084915;5900.498457631095;5909.349971503131;4260.297050986584;4456.64346852251;4464.486584042828;4464.754438505881;4465.062336909245;4315.633171180438;4328.740275583459;4391.429114215163;4397.12057588482;4404.845830395937;4270.0605866709275;4294.763787991659;4297.656187505007;4309.762963037032;4315.374270730742;4156.189543039109;4229.894252643678;4281.250781113308;4285.400043993844;4311.827526898936;3709.51776269086;3719.144596742737;3728.645778651051;3732.216234590739;3734.981325093357;5545.667259964415;5547.029269877755;5550.611457197998;5555.527780138693;5572.0527510323345;5043.268726034705;5056.393232812049;5058.785891386041;5060.367454068241;5060.898782024339;6021.819345419644;6173.722182501753;6191.4118158774845;6244.094606282064;6250.0624906263965;4161.459010328668;4168.458100446923;4169.4162817205615;4170.332746760534;4172.269852775782;6486.383793539653;6514.511411644098;6559.901601475934;6560.442362399202;6567.179102612174;4249.46881639795;4256.851010214627;4258.53156152823;4259.765712885821;4286.828526858953;4222.683298752606;4304.78476076195;4306.461692288464;4307.913841723211;4327.069680018811;5069.290299358093;5070.873228169326;5071.137906555894;5071.771770270347;5074.340335756328;6295.653739044396;6328.841778955563;6330.746770129235;6333.334999825044;6341.587796793194;1526.9465568705043;1545.675408164298;1546.5592306192682;1547.2805145607347;1547.984520154784;988.2242439684813;989.4953573677333;994.6252553499551;995.1889210293588;1004.6132239087858;6108.969455152695;6114;6116.113163591254;6122.295935967331;6122.479589234876;6506.186726659168;6508.8047358579315;6511.706973186218;6512.381323774234;6520.15238019064;5985.191999080155;6096.0855871619615;6101.206843110456;6107.053406721965;6108.908366374508;3490.0227936177403;3553.3959226931483;3560;3596.8381422836037;3624.5106910567265;6693.163354580677;6718.49611279156;6724.260331363546;6733.494987875929;6740.595564266159;6487.383698548725;6528.37980391862;6565.80302590923;6571.441427478718;6619.834504137435;6622.37087476689;6688.565243259172;6707.262201157869;6734.595924244561;6738.46092312604;6487.026945958144;6494.253160886558;6494.350564943468;6496.512761542997;6509.251436084722;6330.366963303817;6378.936210637834;6379.776707815204;6383.808485745435;6413.518986076157;6572.211334639874;6638.336166383323;6678.799636010927;6684.699188536625;6707.128073350434;4278.294081476522;4321.027768752006;4322.5677432256525;4323.52441231458;4329.328954012133;6338.492920566436;6378.075179099097;6380.87238255223;6390.105385245976;6425.807225783234;6207.410296021871;6212.937870621236;6224.533160013108;6228.4705800007505;6320.873582528416;6298.968505157445;6307.148534947723;6308.716107775253;6311.274203466476;6313.210848643919;6163.84590385244;6177.073438984188;6194.101855231056;6198.039303907902;6198.163247961467;6181.1655426516845;6276.529260305404;6323.114763933145;6337.397947195009;6340.048992651139;6212.689365531615;6242.032484964838;6252.124702541739;6253.030780229072;6253.874922501615 22:48:10 INFO - 2015-11-10 22:48:10,373 DEBUG : BROWSER_OUTPUT: |5;yui.html;754.6151462753994;853.9786505337365;855.4183155454289;863.625031164298;889.0487178718773;13966.092204006745;14236.71526569468;14268.928655356709;14287.785683214746;14295.78556321656;13048.217106973589;13211.801822972662;13242.602721918334;13317.866821331783;13412.26232557209;808.7048227396987;826.5371392020458;827.3009307135461;827.7765003449065;828.5401602110826;804.9557274349909;812.175641723648;815.592203898051;816.2531283875247;817.4441379861692;845.3237410071948;852.4970267542149;857.8241460500583;858.6822875536029;860.0496451421184;846.0946786937978;847.2967437027253;852.0882655558523;852.6802449081595;854.0264098927228;628.9088082228097;633.3444884544521;633.8161933039413;634.3497914637487;634.9809505714836;12441.066919981038;12506.49974001039;12519.3740312984;12552.121351505399;12555.497780088877;10937.83593246102;11003.889961100447;11163.106951443864;11242.943785281102;11389.943050284779;9592.66425675105;9611.615535378576;9880.270952583342;10037.146842518394;10051.798964020752;3467.826608669556;3559.537260156189;3603.963960360389;3609.5488063992;3632.219072899339;40870.79564602188;41028.79485602583;44002;45349.773251133534;46659.76670116662;10399.792004159874;10411.895881041244;10426;10506.054455099078;10948;16918.661626767396;16930.830691692925;16936.153192340334;16943.91528042352;18601;7326.450516211199;7402.555846649218;7434.219406962191;7509.436792240604;7542.6605802739;4147.91704165915;4204.3903633972905;4290.099079193405;4292.678049146327;4369.584889435562;3025.6974302570006;3064.586280852101;3067.1565319536858;3067.38652269547;3069.4474994501206;451.22164266640436;455.210210285155;503.94456609772897;506.16482803374726;524.9973750131302;618.5639124417276;650.2619526836979;653.6829637625748;692.5740669488329;718.2279050021248;8157.592120393957;8348.457350272212;8392.664293428317;8433.493990360597;8607.61265743043;611.8164550634792;614.9784757533465;619.615838180322;631.4380201620561;658.7760161545098;3975.503270700747;4054.3715724062818;4055.1484188320783;4071.6539094176733;4088.2845502037026;58461.12308315294;58743.41256587465;59077;59584.10623840559;59685.70157149187;52066.73966630142;52859;52914.73542632262;52947;53097.46902531003;46647.533524665;47089.29366059512;47309.76345118252;47750;48524.51475485271;7709.807254818675;8037.879431808645;8291.170882911661;8751.868721969304;8942;33753.83123084369;34253.48619770656;34288;34720.82639586786;35049.29901401907;46016.309755353024;46359.3046104302;46784;46841.76579117219;46935;7585.0139481867;8125.390595705464;8131.878021829559;8155.306798922158;8452.873206901779;11749.530018799152;11919.225250358699;12139.75720485603;12214.938925305316;12448.81326780081;11143.219974602025;11199.384033878216;11294.830577541179;11629.709257268298;11943.940280298542;11320.433978300887;11458.255213411101;11552.82670759956;11736.76526469483;11834.349110798988;10510.369377837354;10589.9470502647;10755.300905441121;10757.839288376546;11550.88449115498;9564.426134431957;10028.598856045677;10195.337303075275;10268.691939241835;10280.691579252634;8927.285817134743;9677.854832177663;9781.902180978099;9842.606295748375;9845.310828241954 22:48:10 INFO - 2015-11-10 22:48:10,374 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:48:10 INFO - 2015-11-10 22:48:10,374 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:48:10 INFO - 2015-11-10 22:48:10,374 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,894 22:48:10 INFO - 2015-11-10 22:48:10,374 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:48:10 INFO - 2015-11-10 22:48:10,374 DEBUG : BROWSER_OUTPUT: __startTimestamp1447224490364__endTimestamp 22:48:10 INFO - 2015-11-10 22:48:10,374 DEBUG : BROWSER_OUTPUT: 22:48:10 INFO - 2015-11-10 22:48:10,378 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:48:10 INFO - 2015-11-10 22:48:10,378 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:48:10 INFO - 2015-11-10 22:48:10,378 DEBUG : BROWSER_OUTPUT: 22:48:10 INFO - 2015-11-10 22:48:10,378 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5462.61 Median:5702.57 stddev:615.89 (10.8%) stddev-sans-first:591.55 22:48:10 INFO - 2015-11-10 22:48:10,378 DEBUG : BROWSER_OUTPUT: Values: 3195.8 3236.3 3275.1 3286.6 3290.5 5306.6 5420.3 5433.1 5454.9 5465.0 5401.1 5408.2 5450.8 5461.6 5479.7 4939.8 4962.2 5047.4 5115.4 5154.0 4859.0 5074.7 5110.1 5111.4 5158.9 4857.8 4956.8 4967.2 4970.9 4997.7 5038.5 5062.7 5068.9 5076.7 5116.0 4814.3 5026.6 5050.3 5070.9 5079.7 5167.1 5221.7 5242.4 5268.8 5309.8 5889.8 5902.8 5910.8 5919.3 5932.5 5852.4 5963.4 5984.0 5986.4 5988.8 5445.8 5501.3 5518.9 5547.4 5579.1 6031.5 6032.1 6060.2 6063.9 6074.4 5691.4 5831.1 5835.9 5836.9 5898.5 5806.2 5878.0 5880.6 5907.0 5912.8 5841.1 5925.6 5928.3 5931.8 5938.2 5690.5 5807.8 5916.7 5924.6 5925.7 4402.1 4472.2 4489.7 4500.4 4508.9 4000.8 4011.6 4011.9 4018.6 4051.9 5396.3 5574.7 5575.1 5576.2 5583.0 5782.9 5812.1 5879.9 5881.7 5913.7 5433.0 5556.5 5602.3 5606.4 5621.3 4839.2 4915.9 5083.8 5098.3 5139.1 5955.4 6058.7 6068.1 6069.0 6113.5 5870.2 5948.9 5954.5 5957.6 5960.3 5827.3 5940.4 5981.3 6100.4 6140.3 5802.2 5802.7 5803.9 5814.2 5849.3 5852.2 5875.5 5877.8 5879.3 5885.1 5572.9 5696.0 5702.6 5746.7 5833.2 5781.7 5808.0 5808.6 5809.7 5814.5 5700.1 5705.0 5708.7 5718.7 5728.1 5609.5 5718.0 5785.4 5907.3 5928.3 5693.3 5711.4 5711.6 5718.0 5728.5 22:48:10 INFO - 2015-11-10 22:48:10,378 DEBUG : BROWSER_OUTPUT: 22:48:10 INFO - 2015-11-10 22:48:10,378 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:51137.32 Median:18731.87 stddev:90822.02 (484.9%) stddev-sans-first:90997.41 22:48:10 INFO - 2015-11-10 22:48:10,378 DEBUG : BROWSER_OUTPUT: Values: 560.2 579.1 599.5 601.8 627.2 31385.5 39865.6 40103.2 40171.6 40201.2 43734.0 44487.1 44510.1 44538.8 44544.6 7654.0 7746.7 8692.9 9006.3 10273.8 10415.1 10461.3 10519.9 10525.7 10526.7 10491.7 10521.5 10564.5 10583.6 10588.3 7862.0 8050.7 10578.7 10804.2 10832.4 10370.6 10485.4 10491.8 10508.4 10509.1 39716.4 40079.0 40108.8 40140.0 40240.2 3032.6 3047.6 3242.9 3399.6 3662.5 30284.5 30462.7 30466.8 30639.4 31506.2 3461.5 3488.4 3542.1 3558.9 3692.0 289630.0 290985.0 291092.0 291545.0 291911.0 47843.8 48394.3 64694.0 65555.7 65699.7 60632.0 60811.0 60850.0 60894.0 61036.7 12868.6 12945.0 12952.5 12971.4 12984.5 10869.8 10909.6 10928.7 10938.5 10957.9 19148.0 19212.0 19331.2 19462.9 19488.4 7524.4 7715.9 7767.6 7791.5 7795.7 952.7 1035.8 1040.2 1100.5 1118.0 28618.0 29007.7 29245.3 29407.9 34064.1 976.4 1042.4 1062.6 1064.6 1186.8 15593.8 15598.4 15711.4 15721.8 15839.7 388658.0 389638.0 394453.0 395629.0 395980.0 54500.0 55011.4 55043.7 55110.4 55122.4 1282.1 1327.1 1384.9 1391.0 1432.2 23254.5 30857.4 30968.5 31194.5 31321.5 51083.0 51802.7 51813.0 51876.7 51902.7 306528.0 307955.0 308624.0 391151.0 399203.0 32382.8 32699.0 32809.8 33062.2 33200.2 39252.6 40064.6 40418.2 40616.6 40741.2 35972.0 36002.5 36035.5 36172.0 37336.3 36226.3 36619.0 36834.0 36858.8 36917.0 40979.2 40990.0 41150.6 41474.6 41679.6 32423.5 32450.8 35309.0 35385.3 35429.0 26373.2 26470.9 26554.9 26564.2 26889.9 22:48:10 INFO - 2015-11-10 22:48:10,378 DEBUG : BROWSER_OUTPUT: 22:48:10 INFO - 2015-11-10 22:48:10,378 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26523.70 Median:23956.43 stddev:79212.19 (330.7%) stddev-sans-first:79410.01 22:48:10 INFO - 2015-11-10 22:48:10,379 DEBUG : BROWSER_OUTPUT: Values: 344.2 345.1 346.6 346.8 347.4 14395.0 14733.8 16753.8 17057.5 18457.4 14137.9 15388.3 15672.3 15679.5 15782.3 5285.5 5432.0 5432.3 5434.1 5439.3 4023.2 4134.3 5368.5 5408.8 5734.4 5789.5 5805.9 5814.7 5821.6 5822.5 5783.7 5908.9 5932.8 5936.9 5938.0 5195.0 5197.4 5204.6 5207.8 5208.2 13518.2 13946.9 20846.6 21668.7 21728.1 1943.3 2036.4 2062.1 2140.3 2228.1 9858.0 9913.6 10009.8 10104.4 10124.7 1665.5 1680.2 1683.7 1701.9 1773.8 52492.2 56938.0 61150.4 63183.7 63320.4 6795.8 6864.9 6876.7 6887.1 6936.0 8491.6 8543.8 8551.7 8557.6 8561.9 5593.6 5612.9 5613.0 5646.0 5660.5 5302.6 5308.9 5318.0 5646.8 5720.6 3329.8 3357.4 3361.3 3378.6 3379.9 1135.2 1149.2 1170.5 1202.2 1202.4 448.6 494.1 496.5 498.6 511.5 10808.3 12223.2 12376.9 12570.7 12606.7 477.9 480.9 486.1 489.6 510.9 6567.7 6576.5 6683.8 6990.3 6992.4 402959.0 457813.0 480183.0 520940.0 542271.0 73560.0 74364.6 76076.6 76515.0 77946.0 549.2 549.9 556.0 556.1 556.3 11190.2 11386.1 11412.1 11540.4 11548.9 35076.7 35240.0 35507.1 36467.8 36575.6 47206.3 47435.0 55569.0 55779.0 55953.7 13795.4 14591.0 15098.0 15111.5 15182.5 18161.5 18551.1 18621.4 19072.0 19554.1 9301.0 9606.0 11390.4 16000.1 16268.9 9336.3 9429.6 9466.1 9478.1 9648.7 9637.1 9868.2 10014.8 10054.1 10076.2 14943.9 15001.1 15019.0 15283.4 15327.5 15752.7 15775.3 15961.4 16080.7 16309.6 22:48:10 INFO - 2015-11-10 22:48:10,379 DEBUG : BROWSER_OUTPUT: 22:48:10 INFO - 2015-11-10 22:48:10,379 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5276.63 Median:6271.86 stddev:2738.16 (43.7%) stddev-sans-first:2729.84 22:48:10 INFO - 2015-11-10 22:48:10,379 DEBUG : BROWSER_OUTPUT: Values: 1337.9 1681.4 1731.8 1756.3 1776.6 6266.7 7477.7 7619.7 7623.8 7653.4 7506.3 7604.2 7606.4 7611.7 7611.8 2238.7 2261.0 2263.4 2264.3 2265.3 2262.7 2280.4 2293.0 2297.3 2298.2 2192.5 2210.3 2234.8 2243.7 2249.8 2221.0 2260.1 2271.1 2274.8 2275.4 2209.3 2216.2 2219.9 2221.7 2223.7 6452.5 6646.6 7568.9 7582.1 7597.9 4310.4 4400.0 4401.6 4404.5 4413.2 2912.4 2998.2 3029.5 3053.6 3067.1 937.7 941.7 982.5 1012.2 1016.2 10417.4 10488.9 10489.8 10490.4 10501.9 4100.8 4174.7 4180.7 4184.7 4222.0 8934.5 8954.7 8963.2 8969.4 8974.4 4364.9 4373.6 4392.6 4402.4 4407.3 3882.3 3907.0 3915.7 3916.4 3922.3 3441.4 3493.8 3497.2 3499.5 3518.7 1150.4 1153.4 1153.7 1157.3 1173.9 1302.4 1307.3 1328.5 1332.0 1341.6 7133.9 7212.2 7224.4 7227.1 7270.8 456.5 468.0 469.9 470.8 474.5 5044.8 5594.5 5638.5 5648.9 5654.4 7788.2 8695.3 8908.6 8961.7 9023.6 8720.4 8755.3 8767.8 8864.6 8876.6 6986.0 7117.9 7159.2 7160.6 7163.2 6730.7 6850.4 6870.6 6878.7 6897.8 7848.3 8037.2 8070.5 8072.9 8073.0 8127.6 8186.2 8261.9 8342.2 8356.3 6724.9 6756.0 6765.8 6787.5 6806.0 7301.7 7324.3 7344.3 7407.2 7419.2 6756.2 6943.2 7028.6 7040.0 7149.6 6901.0 6923.8 6976.5 6980.3 6983.7 6927.2 6989.0 6994.0 6997.4 6999.4 6476.5 6494.1 6494.1 6510.8 6514.5 6187.8 6265.3 6268.1 6275.6 6311.1 22:48:10 INFO - 2015-11-10 22:48:10,379 DEBUG : BROWSER_OUTPUT: 22:48:10 INFO - 2015-11-10 22:48:10,379 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5193.03 Median:6107.98 stddev:1617.45 (26.5%) stddev-sans-first:1579.64 22:48:10 INFO - 2015-11-10 22:48:10,379 DEBUG : BROWSER_OUTPUT: Values: 294.3 295.2 299.0 299.4 301.9 5864.1 5971.3 5988.9 6001.0 6039.8 5828.3 5897.7 5898.1 5900.5 5909.3 4260.3 4456.6 4464.5 4464.8 4465.1 4315.6 4328.7 4391.4 4397.1 4404.8 4270.1 4294.8 4297.7 4309.8 4315.4 4156.2 4229.9 4281.3 4285.4 4311.8 3709.5 3719.1 3728.6 3732.2 3735.0 5545.7 5547.0 5550.6 5555.5 5572.1 5043.3 5056.4 5058.8 5060.4 5060.9 6021.8 6173.7 6191.4 6244.1 6250.1 4161.5 4168.5 4169.4 4170.3 4172.3 6486.4 6514.5 6559.9 6560.4 6567.2 4249.5 4256.9 4258.5 4259.8 4286.8 4222.7 4304.8 4306.5 4307.9 4327.1 5069.3 5070.9 5071.1 5071.8 5074.3 6295.7 6328.8 6330.7 6333.3 6341.6 1526.9 1545.7 1546.6 1547.3 1548.0 988.2 989.5 994.6 995.2 1004.6 6109.0 6114.0 6116.1 6122.3 6122.5 6506.2 6508.8 6511.7 6512.4 6520.2 5985.2 6096.1 6101.2 6107.1 6108.9 3490.0 3553.4 3560.0 3596.8 3624.5 6693.2 6718.5 6724.3 6733.5 6740.6 6487.4 6528.4 6565.8 6571.4 6619.8 6622.4 6688.6 6707.3 6734.6 6738.5 6487.0 6494.3 6494.4 6496.5 6509.3 6330.4 6378.9 6379.8 6383.8 6413.5 6572.2 6638.3 6678.8 6684.7 6707.1 4278.3 4321.0 4322.6 4323.5 4329.3 6338.5 6378.1 6380.9 6390.1 6425.8 6207.4 6212.9 6224.5 6228.5 6320.9 6299.0 6307.1 6308.7 6311.3 6313.2 6163.8 6177.1 6194.1 6198.0 6198.2 6181.2 6276.5 6323.1 6337.4 6340.0 6212.7 6242.0 6252.1 6253.0 6253.9 22:48:10 INFO - 2015-11-10 22:48:10,379 DEBUG : BROWSER_OUTPUT: 22:48:10 INFO - 2015-11-10 22:48:10,379 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13670.50 Median:46721.88 stddev:16096.43 (34.5%) stddev-sans-first:16112.37 22:48:10 INFO - 2015-11-10 22:48:10,381 DEBUG : BROWSER_OUTPUT: Values: 754.6 854.0 855.4 863.6 889.0 13966.1 14236.7 14268.9 14287.8 14295.8 13048.2 13211.8 13242.6 13317.9 13412.3 808.7 826.5 827.3 827.8 828.5 805.0 812.2 815.6 816.3 817.4 845.3 852.5 857.8 858.7 860.0 846.1 847.3 852.1 852.7 854.0 628.9 633.3 633.8 634.3 635.0 12441.1 12506.5 12519.4 12552.1 12555.5 10937.8 11003.9 11163.1 11242.9 11389.9 9592.7 9611.6 9880.3 10037.1 10051.8 3467.8 3559.5 3604.0 3609.5 3632.2 40870.8 41028.8 44002.0 45349.8 46659.8 10399.8 10411.9 10426.0 10506.1 10948.0 16918.7 16930.8 16936.2 16943.9 18601.0 7326.5 7402.6 7434.2 7509.4 7542.7 4147.9 4204.4 4290.1 4292.7 4369.6 3025.7 3064.6 3067.2 3067.4 3069.4 451.2 455.2 503.9 506.2 525.0 618.6 650.3 653.7 692.6 718.2 8157.6 8348.5 8392.7 8433.5 8607.6 611.8 615.0 619.6 631.4 658.8 3975.5 4054.4 4055.1 4071.7 4088.3 58461.1 58743.4 59077.0 59584.1 59685.7 52066.7 52859.0 52914.7 52947.0 53097.5 46647.5 47089.3 47309.8 47750.0 48524.5 7709.8 8037.9 8291.2 8751.9 8942.0 33753.8 34253.5 34288.0 34720.8 35049.3 46016.3 46359.3 46784.0 46841.8 46935.0 7585.0 8125.4 8131.9 8155.3 8452.9 11749.5 11919.2 12139.8 12214.9 12448.8 11143.2 11199.4 11294.8 11629.7 11943.9 11320.4 11458.3 11552.8 11736.8 11834.3 10510.4 10589.9 10755.3 10757.8 11550.9 9564.4 10028.6 10195.3 10268.7 10280.7 8927.3 9677.9 9781.9 9842.6 9845.3 22:48:10 INFO - 2015-11-10 22:48:10,381 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:48:10 INFO - 2015-11-10 22:48:10,381 DEBUG : BROWSER_OUTPUT: 22:48:11 INFO - 2015-11-10 22:48:11,087 INFO : Browser exited with error code: 0 22:48:11 INFO - 2015-11-10 22:48:11,104 INFO : Completed test dromaeo_css (00:18:33) 22:48:11 INFO - 2015-11-10 22:48:11,104 INFO : Starting test kraken 22:48:11 INFO - 2015-11-10 22:48:11,104 DEBUG : operating with platform_type : linux_ 22:48:11 INFO - 2015-11-10 22:48:11,104 INFO : Initialising browser for kraken test... 22:48:11 INFO - 2015-11-10 22:48:11,110 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCjNr4n/profile http://localhost:32960/getInfo.html 22:48:15 INFO - 2015-11-10 22:48:15,299 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:48:15 INFO - 2015-11-10 22:48:15,300 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:48:15 INFO - 2015-11-10 22:48:15,300 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:48:15 INFO - 2015-11-10 22:48:15,300 DEBUG : BROWSER_OUTPUT: __metrics 22:48:15 INFO - 2015-11-10 22:48:15,388 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:48:16 INFO - 2015-11-10 22:48:16,881 INFO : Browser initialized. 22:48:16 INFO - 2015-11-10 22:48:16,881 INFO : Running cycle 1/1 for kraken test... 22:48:16 INFO - 2015-11-10 22:48:16,882 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCjNr4n/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:48:28 INFO - 2015-11-10 22:48:28,639 DEBUG : BROWSER_OUTPUT: RSS: Main: 139485184 22:48:28 INFO - 2015-11-10 22:48:28,640 DEBUG : BROWSER_OUTPUT: 22:48:31 INFO - 2015-11-10 22:48:31,099 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32960/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32960/tests/kraken/driver.html?testName=audio-beat-detection) 22:48:31 INFO - 2015-11-10 22:48:31,674 DEBUG : BROWSER_OUTPUT: RSS: Main: 179646464 22:48:31 INFO - 2015-11-10 22:48:31,674 DEBUG : BROWSER_OUTPUT: 22:48:34 INFO - 2015-11-10 22:48:34,257 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32960/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32960/tests/kraken/driver.html?testName=audio-dft) 22:48:34 INFO - 2015-11-10 22:48:34,831 DEBUG : BROWSER_OUTPUT: RSS: Main: 168603648 22:48:34 INFO - 2015-11-10 22:48:34,831 DEBUG : BROWSER_OUTPUT: 22:48:37 INFO - 2015-11-10 22:48:37,650 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32960/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32960/tests/kraken/driver.html?testName=audio-fft) 22:48:38 INFO - 2015-11-10 22:48:38,211 DEBUG : BROWSER_OUTPUT: RSS: Main: 149942272 22:48:38 INFO - 2015-11-10 22:48:38,211 DEBUG : BROWSER_OUTPUT: 22:48:40 INFO - 2015-11-10 22:48:40,185 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32960/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32960/tests/kraken/driver.html?testName=audio-oscillator) 22:48:40 INFO - 2015-11-10 22:48:40,747 DEBUG : BROWSER_OUTPUT: RSS: Main: 154902528 22:48:40 INFO - 2015-11-10 22:48:40,747 DEBUG : BROWSER_OUTPUT: 22:48:42 INFO - 2015-11-10 22:48:42,900 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32960/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32960/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:48:43 INFO - 2015-11-10 22:48:43,461 DEBUG : BROWSER_OUTPUT: RSS: Main: 155922432 22:48:43 INFO - 2015-11-10 22:48:43,461 DEBUG : BROWSER_OUTPUT: 22:48:46 INFO - 2015-11-10 22:48:46,400 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32960/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32960/tests/kraken/driver.html?testName=imaging-darkroom) 22:48:46 INFO - 2015-11-10 22:48:46,974 DEBUG : BROWSER_OUTPUT: RSS: Main: 155885568 22:48:46 INFO - 2015-11-10 22:48:46,975 DEBUG : BROWSER_OUTPUT: 22:48:50 INFO - 2015-11-10 22:48:50,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32960/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32960/tests/kraken/driver.html?testName=imaging-desaturate) 22:48:50 INFO - 2015-11-10 22:48:50,922 DEBUG : BROWSER_OUTPUT: RSS: Main: 156213248 22:48:50 INFO - 2015-11-10 22:48:50,922 DEBUG : BROWSER_OUTPUT: 22:48:53 INFO - 2015-11-10 22:48:53,669 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32960/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32960/tests/kraken/driver.html?testName=json-parse-financial) 22:48:54 INFO - 2015-11-10 22:48:54,250 DEBUG : BROWSER_OUTPUT: RSS: Main: 157356032 22:48:54 INFO - 2015-11-10 22:48:54,250 DEBUG : BROWSER_OUTPUT: 22:48:55 INFO - 2015-11-10 22:48:55,786 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32960/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32960/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:48:56 INFO - 2015-11-10 22:48:56,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 166195200 22:48:56 INFO - 2015-11-10 22:48:56,353 DEBUG : BROWSER_OUTPUT: 22:48:58 INFO - 2015-11-10 22:48:58,148 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32960/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32960/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:48:58 INFO - 2015-11-10 22:48:58,750 DEBUG : BROWSER_OUTPUT: RSS: Main: 165982208 22:48:58 INFO - 2015-11-10 22:48:58,750 DEBUG : BROWSER_OUTPUT: 22:49:00 INFO - 2015-11-10 22:49:00,782 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32960/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32960/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:49:01 INFO - 2015-11-10 22:49:01,350 DEBUG : BROWSER_OUTPUT: RSS: Main: 176304128 22:49:01 INFO - 2015-11-10 22:49:01,350 DEBUG : BROWSER_OUTPUT: 22:49:03 INFO - 2015-11-10 22:49:03,744 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32960/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32960/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:49:04 INFO - 2015-11-10 22:49:04,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 180465664 22:49:04 INFO - 2015-11-10 22:49:04,326 DEBUG : BROWSER_OUTPUT: 22:49:06 INFO - 2015-11-10 22:49:06,854 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32960/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32960/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:49:07 INFO - 2015-11-10 22:49:07,423 DEBUG : BROWSER_OUTPUT: RSS: Main: 179048448 22:49:07 INFO - 2015-11-10 22:49:07,423 DEBUG : BROWSER_OUTPUT: 22:49:09 INFO - 2015-11-10 22:49:09,096 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32960/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32960/tests/kraken/driver.html?testName=ai-astar) 22:49:09 INFO - 2015-11-10 22:49:09,347 DEBUG : BROWSER_OUTPUT: RSS: Main: 239132672 22:49:09 INFO - 2015-11-10 22:49:09,348 DEBUG : BROWSER_OUTPUT: 22:49:09 INFO - 2015-11-10 22:49:09,348 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:49:09 INFO - 2015-11-10 22:49:09,348 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:49:09 INFO - 2015-11-10 22:49:09,349 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:49:09 INFO - 2015-11-10 22:49:09,349 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:49:09 INFO - 2015-11-10 22:49:09,349 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;110;105;109;110;111;101;110;112;113 22:49:09 INFO - 2015-11-10 22:49:09,349 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;124;149;163;125;153;153;129;169;125 22:49:09 INFO - 2015-11-10 22:49:09,350 DEBUG : BROWSER_OUTPUT: |2;audio-dft;159;160;161;159;160;161;161;164;160;161 22:49:09 INFO - 2015-11-10 22:49:09,350 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;80;94;71;71;72;101;90;71 22:49:09 INFO - 2015-11-10 22:49:09,350 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;91;131;91;90;90;143;89;91;135 22:49:09 INFO - 2015-11-10 22:49:09,350 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;110;111;109;109;109;110;110;109 22:49:09 INFO - 2015-11-10 22:49:09,351 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;145;146;146;146;145;146;146;145 22:49:09 INFO - 2015-11-10 22:49:09,351 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;96;95;95;95;96;96;95 22:49:09 INFO - 2015-11-10 22:49:09,351 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;59;60;57;57;57;58;67;56;56 22:49:09 INFO - 2015-11-10 22:49:09,352 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;67;68;67;69;67;67;67;67;68 22:49:09 INFO - 2015-11-10 22:49:09,352 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;83;90;84;84;86;85;84;85;86 22:49:09 INFO - 2015-11-10 22:49:09,352 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;121;114;119;115;122;118;122;125;123 22:49:09 INFO - 2015-11-10 22:49:09,352 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;140;149;150;150;149;150;149;155;139 22:49:09 INFO - 2015-11-10 22:49:09,352 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;67;66;66;66;67;67;65;65;66 22:49:09 INFO - 2015-11-10 22:49:09,353 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:49:09 INFO - 2015-11-10 22:49:09,353 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:49:09 INFO - 2015-11-10 22:49:09,353 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,900 22:49:09 INFO - 2015-11-10 22:49:09,353 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:49:09 INFO - 2015-11-10 22:49:09,354 DEBUG : BROWSER_OUTPUT: __startTimestamp1447224549347__endTimestamp 22:49:09 INFO - 2015-11-10 22:49:09,354 DEBUG : BROWSER_OUTPUT: 22:49:09 INFO - 2015-11-10 22:49:09,357 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:49:09 INFO - 2015-11-10 22:49:09,357 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:49:09 INFO - 2015-11-10 22:49:09,357 DEBUG : BROWSER_OUTPUT: 22:49:09 INFO - 2015-11-10 22:49:09,357 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:3.53 (3.2%) stddev-sans-first:3.74 22:49:09 INFO - 2015-11-10 22:49:09,358 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 105.0 109.0 110.0 111.0 101.0 110.0 112.0 113.0 22:49:09 INFO - 2015-11-10 22:49:09,358 DEBUG : BROWSER_OUTPUT: 22:49:09 INFO - 2015-11-10 22:49:09,358 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.80 Median:151.00 stddev:16.78 (11.1%) stddev-sans-first:17.73 22:49:09 INFO - 2015-11-10 22:49:09,358 DEBUG : BROWSER_OUTPUT: Values: 148.0 124.0 149.0 163.0 125.0 153.0 153.0 129.0 169.0 125.0 22:49:09 INFO - 2015-11-10 22:49:09,358 DEBUG : BROWSER_OUTPUT: 22:49:09 INFO - 2015-11-10 22:49:09,358 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.43 (0.9%) stddev-sans-first:1.39 22:49:09 INFO - 2015-11-10 22:49:09,358 DEBUG : BROWSER_OUTPUT: Values: 159.0 160.0 161.0 159.0 160.0 161.0 161.0 164.0 160.0 161.0 22:49:09 INFO - 2015-11-10 22:49:09,358 DEBUG : BROWSER_OUTPUT: 22:49:09 INFO - 2015-11-10 22:49:09,358 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.30 Median:72.00 stddev:11.47 (15.9%) stddev-sans-first:11.86 22:49:09 INFO - 2015-11-10 22:49:09,359 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 80.0 94.0 71.0 71.0 72.0 101.0 90.0 71.0 22:49:09 INFO - 2015-11-10 22:49:09,359 DEBUG : BROWSER_OUTPUT: 22:49:09 INFO - 2015-11-10 22:49:09,359 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.10 Median:90.00 stddev:22.44 (24.9%) stddev-sans-first:23.21 22:49:09 INFO - 2015-11-10 22:49:09,359 DEBUG : BROWSER_OUTPUT: Values: 90.0 91.0 131.0 91.0 90.0 90.0 143.0 89.0 91.0 135.0 22:49:09 INFO - 2015-11-10 22:49:09,359 DEBUG : BROWSER_OUTPUT: 22:49:09 INFO - 2015-11-10 22:49:09,359 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 22:49:09 INFO - 2015-11-10 22:49:09,359 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 110.0 111.0 109.0 109.0 109.0 110.0 110.0 109.0 22:49:09 INFO - 2015-11-10 22:49:09,359 DEBUG : BROWSER_OUTPUT: 22:49:09 INFO - 2015-11-10 22:49:09,359 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 22:49:09 INFO - 2015-11-10 22:49:09,360 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 145.0 146.0 146.0 146.0 145.0 146.0 146.0 145.0 22:49:09 INFO - 2015-11-10 22:49:09,360 DEBUG : BROWSER_OUTPUT: 22:49:09 INFO - 2015-11-10 22:49:09,360 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 22:49:09 INFO - 2015-11-10 22:49:09,360 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 22:49:09 INFO - 2015-11-10 22:49:09,360 DEBUG : BROWSER_OUTPUT: 22:49:09 INFO - 2015-11-10 22:49:09,360 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.50 Median:58.00 stddev:3.24 (5.6%) stddev-sans-first:3.43 22:49:09 INFO - 2015-11-10 22:49:09,360 DEBUG : BROWSER_OUTPUT: Values: 58.0 59.0 60.0 57.0 57.0 57.0 58.0 67.0 56.0 56.0 22:49:09 INFO - 2015-11-10 22:49:09,360 DEBUG : BROWSER_OUTPUT: 22:49:09 INFO - 2015-11-10 22:49:09,360 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 22:49:09 INFO - 2015-11-10 22:49:09,360 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 68.0 67.0 69.0 67.0 67.0 67.0 67.0 68.0 22:49:09 INFO - 2015-11-10 22:49:09,360 DEBUG : BROWSER_OUTPUT: 22:49:09 INFO - 2015-11-10 22:49:09,360 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.00 stddev:1.93 (2.3%) stddev-sans-first:2.05 22:49:09 INFO - 2015-11-10 22:49:09,361 DEBUG : BROWSER_OUTPUT: Values: 85.0 83.0 90.0 84.0 84.0 86.0 85.0 84.0 85.0 86.0 22:49:09 INFO - 2015-11-10 22:49:09,361 DEBUG : BROWSER_OUTPUT: 22:49:09 INFO - 2015-11-10 22:49:09,361 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.90 Median:121.50 stddev:3.48 (2.9%) stddev-sans-first:3.69 22:49:09 INFO - 2015-11-10 22:49:09,361 DEBUG : BROWSER_OUTPUT: Values: 120.0 121.0 114.0 119.0 115.0 122.0 118.0 122.0 125.0 123.0 22:49:09 INFO - 2015-11-10 22:49:09,361 DEBUG : BROWSER_OUTPUT: 22:49:09 INFO - 2015-11-10 22:49:09,361 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.20 Median:149.50 stddev:5.29 (3.5%) stddev-sans-first:5.11 22:49:09 INFO - 2015-11-10 22:49:09,361 DEBUG : BROWSER_OUTPUT: Values: 141.0 140.0 149.0 150.0 150.0 149.0 150.0 149.0 155.0 139.0 22:49:09 INFO - 2015-11-10 22:49:09,361 DEBUG : BROWSER_OUTPUT: 22:49:09 INFO - 2015-11-10 22:49:09,361 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:0.95 (1.4%) stddev-sans-first:0.78 22:49:09 INFO - 2015-11-10 22:49:09,361 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 66.0 66.0 66.0 67.0 67.0 65.0 65.0 66.0 22:49:09 INFO - 2015-11-10 22:49:09,361 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:49:09 INFO - 2015-11-10 22:49:09,361 DEBUG : BROWSER_OUTPUT: 22:49:10 INFO - 2015-11-10 22:49:10,211 INFO : Browser exited with error code: 0 22:49:10 INFO - 2015-11-10 22:49:10,266 INFO : Completed test kraken (00:00:59) 22:49:10 INFO - 2015-11-10 22:49:10,266 INFO : Starting test v8_7 22:49:10 INFO - 2015-11-10 22:49:10,266 DEBUG : operating with platform_type : linux_ 22:49:10 INFO - 2015-11-10 22:49:10,267 INFO : Initialising browser for v8_7 test... 22:49:10 INFO - 2015-11-10 22:49:10,272 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUB6L1Y/profile http://localhost:32960/getInfo.html 22:49:14 INFO - 2015-11-10 22:49:14,545 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:49:14 INFO - 2015-11-10 22:49:14,545 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:49:14 INFO - 2015-11-10 22:49:14,545 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:49:14 INFO - 2015-11-10 22:49:14,545 DEBUG : BROWSER_OUTPUT: __metrics 22:49:14 INFO - 2015-11-10 22:49:14,703 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:49:16 INFO - 2015-11-10 22:49:16,093 INFO : Browser initialized. 22:49:16 INFO - 2015-11-10 22:49:16,094 INFO : Running cycle 1/1 for v8_7 test... 22:49:16 INFO - 2015-11-10 22:49:16,094 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUB6L1Y/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:49:27 INFO - 2015-11-10 22:49:27,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 139472896 22:49:27 INFO - 2015-11-10 22:49:27,826 DEBUG : BROWSER_OUTPUT: 22:49:49 INFO - 2015-11-10 22:49:49,200 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32960/tests/v8_7/run.html (next: http://localhost:32960/tests/v8_7/run.html) 22:49:49 INFO - 2015-11-10 22:49:49,450 DEBUG : BROWSER_OUTPUT: RSS: Main: 595369984 22:49:49 INFO - 2015-11-10 22:49:49,450 DEBUG : BROWSER_OUTPUT: 22:49:49 INFO - 2015-11-10 22:49:49,451 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:49:49 INFO - 2015-11-10 22:49:49,451 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:49:49 INFO - 2015-11-10 22:49:49,451 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:49:49 INFO - 2015-11-10 22:49:49,451 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:49:49 INFO - 2015-11-10 22:49:49,451 DEBUG : BROWSER_OUTPUT: |0;Richards;163.371998039536 22:49:49 INFO - 2015-11-10 22:49:49,451 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.3634596695821 22:49:49 INFO - 2015-11-10 22:49:49,452 DEBUG : BROWSER_OUTPUT: |2;Encrypt;287.4389192296637 22:49:49 INFO - 2015-11-10 22:49:49,452 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5045.226130653266 22:49:49 INFO - 2015-11-10 22:49:49,452 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1100.1100110011 22:49:49 INFO - 2015-11-10 22:49:49,452 DEBUG : BROWSER_OUTPUT: |5;Earley;794.2811755361398 22:49:49 INFO - 2015-11-10 22:49:49,452 DEBUG : BROWSER_OUTPUT: |6;Boyer;11651.162790697674 22:49:49 INFO - 2015-11-10 22:49:49,452 DEBUG : BROWSER_OUTPUT: |7;RegExp;26315.78947368421 22:49:49 INFO - 2015-11-10 22:49:49,453 DEBUG : BROWSER_OUTPUT: |8;Splay;665.7789613848203 22:49:49 INFO - 2015-11-10 22:49:49,453 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 22:49:49 INFO - 2015-11-10 22:49:49,453 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:49:49 INFO - 2015-11-10 22:49:49,453 DEBUG : BROWSER_OUTPUT: __startTimestamp1447224589447__endTimestamp 22:49:49 INFO - 2015-11-10 22:49:49,453 DEBUG : BROWSER_OUTPUT: 22:49:49 INFO - 2015-11-10 22:49:49,453 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:49:49 INFO - 2015-11-10 22:49:49,453 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:49:49 INFO - 2015-11-10 22:49:49,454 DEBUG : BROWSER_OUTPUT: 22:49:49 INFO - 2015-11-10 22:49:49,454 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.37 Median:163.37 stddev:0.00 (0.0%) 22:49:49 INFO - 2015-11-10 22:49:49,454 DEBUG : BROWSER_OUTPUT: Values: 163.4 22:49:49 INFO - 2015-11-10 22:49:49,454 DEBUG : BROWSER_OUTPUT: 22:49:49 INFO - 2015-11-10 22:49:49,454 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.36 Median:194.36 stddev:0.00 (0.0%) 22:49:49 INFO - 2015-11-10 22:49:49,454 DEBUG : BROWSER_OUTPUT: Values: 194.4 22:49:49 INFO - 2015-11-10 22:49:49,454 DEBUG : BROWSER_OUTPUT: 22:49:49 INFO - 2015-11-10 22:49:49,455 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:287.44 Median:287.44 stddev:0.00 (0.0%) 22:49:49 INFO - 2015-11-10 22:49:49,455 DEBUG : BROWSER_OUTPUT: Values: 287.4 22:49:49 INFO - 2015-11-10 22:49:49,455 DEBUG : BROWSER_OUTPUT: 22:49:49 INFO - 2015-11-10 22:49:49,455 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5045.23 Median:5045.23 stddev:0.00 (0.0%) 22:49:49 INFO - 2015-11-10 22:49:49,455 DEBUG : BROWSER_OUTPUT: Values: 5045.2 22:49:49 INFO - 2015-11-10 22:49:49,455 DEBUG : BROWSER_OUTPUT: 22:49:49 INFO - 2015-11-10 22:49:49,455 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1100.11 Median:1100.11 stddev:0.00 (0.0%) 22:49:49 INFO - 2015-11-10 22:49:49,456 DEBUG : BROWSER_OUTPUT: Values: 1100.1 22:49:49 INFO - 2015-11-10 22:49:49,456 DEBUG : BROWSER_OUTPUT: 22:49:49 INFO - 2015-11-10 22:49:49,456 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:794.28 Median:794.28 stddev:0.00 (0.0%) 22:49:49 INFO - 2015-11-10 22:49:49,456 DEBUG : BROWSER_OUTPUT: Values: 794.3 22:49:49 INFO - 2015-11-10 22:49:49,456 DEBUG : BROWSER_OUTPUT: 22:49:49 INFO - 2015-11-10 22:49:49,456 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11651.16 Median:11651.16 stddev:0.00 (0.0%) 22:49:49 INFO - 2015-11-10 22:49:49,456 DEBUG : BROWSER_OUTPUT: Values: 11651.2 22:49:49 INFO - 2015-11-10 22:49:49,456 DEBUG : BROWSER_OUTPUT: 22:49:49 INFO - 2015-11-10 22:49:49,457 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26315.79 Median:26315.79 stddev:0.00 (0.0%) 22:49:49 INFO - 2015-11-10 22:49:49,457 DEBUG : BROWSER_OUTPUT: Values: 26315.8 22:49:49 INFO - 2015-11-10 22:49:49,457 DEBUG : BROWSER_OUTPUT: 22:49:49 INFO - 2015-11-10 22:49:49,457 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:665.78 Median:665.78 stddev:0.00 (0.0%) 22:49:49 INFO - 2015-11-10 22:49:49,457 DEBUG : BROWSER_OUTPUT: Values: 665.8 22:49:49 INFO - 2015-11-10 22:49:49,457 DEBUG : BROWSER_OUTPUT: 22:49:49 INFO - 2015-11-10 22:49:49,457 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 22:49:49 INFO - 2015-11-10 22:49:49,458 DEBUG : BROWSER_OUTPUT: Values: 4835.7 22:49:49 INFO - 2015-11-10 22:49:49,458 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:49:49 INFO - 2015-11-10 22:49:49,458 DEBUG : BROWSER_OUTPUT: 22:49:50 INFO - 2015-11-10 22:49:50,351 INFO : Browser exited with error code: 0 22:49:50 INFO - 2015-11-10 22:49:50,363 INFO : Completed test v8_7 (00:00:40) 22:49:50 INFO - 2015-11-10 22:49:50,495 INFO : Completed test suite (00:20:12) 22:49:50 INFO - 2015-11-10 22:49:50,496 DEBUG : Working with test: dromaeo_css 22:49:50 INFO - 2015-11-10 22:49:50,496 DEBUG : Generating results file: dromaeo_css 22:49:50 INFO - 2015-11-10 22:49:50,497 DEBUG : Working with test: kraken 22:49:50 INFO - 2015-11-10 22:49:50,497 DEBUG : Generating results file: kraken 22:49:50 INFO - 2015-11-10 22:49:50,497 INFO : javascript benchmark 22:49:50 INFO - 2015-11-10 22:49:50,497 DEBUG : Working with test: v8_7 22:49:50 INFO - 2015-11-10 22:49:50,498 DEBUG : Generating results file: v8_7 22:49:50 INFO - 2015-11-10 22:49:50,498 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:49:50 INFO - 2015-11-10 22:49:50,563 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 22:49:50 INFO - 2015-11-10 22:49:50,563 DEBUG : process_Request line: dromaeo_css 6802.14 graph.html#tests=[[72,63,35]] 22:49:50 INFO - 2015-11-10 22:49:50,563 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:49:50 INFO - 2015-11-10 22:49:50,611 DEBUG : process_Request line: kraken 1492.20 graph.html#tests=[[232,63,35]] 22:49:50 INFO - 2015-11-10 22:49:50,611 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:49:50 INFO - 2015-11-10 22:49:50,661 DEBUG : process_Request line: v8_7 20871.06 graph.html#tests=[[230,63,35]] 22:49:50 INFO - 2015-11-10 22:49:50,663 INFO : javascript benchmark 22:49:50 INFO - 2015-11-10 22:49:50,667 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [344.2340791738384, 345.0838025043509, 346.61525706465824, 346.82485344900823, 347.36085602491426, 14395.0, 14733.778993315082, 16753.832461675378, 17057.488275351727, 18457.446276611707, 14137.929310353435, 15388.307526161321, 15672.294746736396, 15679.45121920733, 15782.289796959136, 5285.497877701622, 5431.972840135813, 5432.266644003068, 5434.130539113743, 5439.3200849893765, 4023.1953609278116, 4134.255833949888, 5368.543673787733, 5408.756605952742, 5734.369219385864, 5789.4500022498005, 5805.941940580604, 5814.680192589406, 5821.563382746311, 5822.505087067604, 5783.6529808211435, 5908.88182236355, 5932.822015339503, 5936.881262374772, 5937.970310148443, 5195.0, 5197.402298735656, 5204.609654275907, 5207.791688332462, 5208.218767184915, 13518.188908665512, 13946.86053139476, 20846.583068338547, 21668.674969875465, 21728.13087476499, 1943.3004118517322, 2036.4399790057705, 2062.092679221138, 2140.2616097446357, 2228.1198926424136, 9857.96491368403, 9913.553890074963, 10009.849852252222, 10104.393736375841, 10124.69625911224, 1665.4504013675457, 1680.15992003998, 1683.6716840216163, 1701.897886126824, 1773.7605423267823, 52492.21261681078, 56938.0, 61150.388496114916, 63183.6840815793, 63320.36679633191, 6795.7961261162245, 6864.897026544606, 6876.69054892521, 6887.104676392037, 6936.0, 8491.575421228914, 8543.786405339792, 8551.700690475927, 8557.614907329185, 8561.871571926426, 5593.636413633101, 5612.915806262909, 5613.045782216951, 5645.9717701412055, 5660.462256085665, 5302.628815982845, 5308.893822123536, 5317.973410132925, 5646.830595082154, 5720.599558030898, 3329.7502687298065, 3357.4292370297107, 3361.2605226850055, 3378.6283508814013, 3379.932401351959, 1135.1940122512942, 1149.2070471374725, 1170.5317872850928, 1202.1825158892038, 1202.392791640216, 448.59402240971974, 494.0982706560541, 496.5134168514876, 498.551303826559, 511.52428241735544, 10808.297460665031, 12223.205491643015, 12376.938115309365, 12570.68573285657, 12606.684832879251, 477.8661974647104, 480.93507376504425, 486.1104179351778, 489.5593965431069, 510.8595136337537, 6567.704453299613, 6576.539642225094, 6683.832904177434, 6990.266022067712, 6992.440604751608, 402959.0, 457813.0, 480183.0, 520940.0, 542271.0, 73560.0, 74364.62817685877, 76076.61961690156, 76515.0, 77946.0, 549.2118809508369, 549.8872731090117, 555.9610827242135, 556.1102236421774, 556.2851735519838, 11190.160737944523, 11386.146039046938, 11412.144089193178, 11540.422978851191, 11548.94225528867, 35076.66771656689, 35240.0, 35507.11232219112, 36467.817660911525, 36575.63424365722, 47206.29190562213, 47435.0, 55569.0, 55779.0, 55953.72023140021, 13795.379207935868, 14591.0, 15098.0, 15111.54665360041, 15182.46861359847, 18161.545961351072, 18551.072446377897, 18621.44135675932, 19072.0, 19554.120064597413, 9301.0, 9606.0, 11390.361314104355, 16000.119993400474, 16268.918655406647, 9336.253099751868, 9429.575669095044, 9466.148046675833, 9478.146966773023, 9648.662296819859, 9637.132658060807, 9868.210543156387, 10014.799704006025, 10054.095131438205, 10076.244281678757, 14943.90785290082, 15001.099934003994, 15019.0, 15283.388664453298, 15327.540173794803, 15752.684946301239, 15775.29011194476, 15961.44134955271, 16080.67838643244, 16309.59226019359], "dojo.html": [3195.760317976152, 3236.304194598164, 3275.099347679388, 3286.6384697683266, 3290.5228741832434, 5306.602004849642, 5420.268263784388, 5433.130699088147, 5454.918176227355, 5465.016297066526, 5401.081816091264, 5408.242846001563, 5450.809221677232, 5461.644993075447, 5479.698616576086, 4939.777710003059, 4962.1812400953795, 5047.419546752134, 5115.360579927509, 5154.0, 4859.0, 5074.746262686869, 5110.1312776827845, 5111.437741848394, 5158.871028224287, 4857.781399837016, 4956.826511072095, 4967.230079337708, 4970.925436118443, 4997.6501644884875, 5038.521340472649, 5062.67092638981, 5068.898622027576, 5076.670016448919, 5116.027954688598, 4814.253790662453, 5026.5727413169925, 5050.292958985745, 5070.923936140961, 5079.746012699387, 5167.069927413064, 5221.71280579568, 5242.370915490127, 5268.841934741964, 5309.840704778863, 5889.823305300848, 5902.793402230945, 5910.763569457216, 5919.289685237756, 5932.495737862287, 5852.414758524156, 5963.373845746221, 5984.0, 5986.3714309997695, 5988.790392336247, 5445.754941027663, 5501.339839219319, 5518.889622207534, 5547.389787123413, 5579.13523403873, 6031.517478601701, 6032.065029920369, 6060.184379892085, 6063.878722425527, 6074.36219196978, 5691.373948865621, 5831.096180092092, 5835.941640583625, 5836.9124463133085, 5898.498627616615, 5806.187133801272, 5877.970610147007, 5880.647161170344, 5906.970465147647, 5912.793052243151, 5841.1238314253205, 5925.644461332334, 5928.347881733006, 5931.822045338647, 5938.168656388109, 5690.5447564194765, 5807.767689292466, 5916.674582897982, 5924.555658325643, 5925.674087925206, 4402.097569998143, 4472.239719247736, 4489.663275254369, 4500.4149460569915, 4508.932366014513, 4000.8399664013114, 4011.5988401159652, 4011.919761604752, 4018.557958624549, 4051.8987025324013, 5396.325459317585, 5574.693391863487, 5575.107982722745, 5576.247206627054, 5583.0, 5782.942170578241, 5812.128180772918, 5879.882402351929, 5881.735321910524, 5913.674747888907, 5433.0, 5556.472135147154, 5602.327720673546, 5606.355269144019, 5621.269234999424, 4839.177339852234, 4915.926261106087, 5083.847484575469, 5098.337216161949, 5139.12634852076, 5955.434233747787, 6058.666773327509, 6068.059450785136, 6069.0, 6113.541484388688, 5870.236869206976, 5948.881022379442, 5954.46409823118, 5957.6127551709, 5960.344362120077, 5827.3007239131575, 5940.435658612425, 5981.312149102909, 6100.389961003864, 6140.263168419819, 5802.187693722966, 5802.65184088956, 5803.912941305968, 5814.156947242711, 5849.298084229919, 5852.18069470266, 5875.50058245054, 5877.823665290048, 5879.2944846618675, 5885.087811389241, 5572.944270557405, 5696.0, 5702.572307076903, 5746.655200687972, 5833.183354330312, 5781.682007489629, 5807.970960145172, 5808.5643576732755, 5809.709514524341, 5814.5348372130975, 5700.116481945305, 5704.971475142598, 5708.714564271687, 5718.685472299064, 5728.140778883201, 5609.467100625434, 5718.0, 5785.4214578541805, 5907.2911250650195, 5928.347881733092, 5693.259876216065, 5711.400302968129, 5711.571632127524, 5718.0, 5728.541716662574], "mootools.html": [1337.9464821407144, 1681.352679218501, 1731.800842903066, 1756.3325936144263, 1776.5647416382988, 6266.686665666715, 7477.663505142268, 7619.657115429805, 7623.809404764884, 7653.4259930505295, 7506.324430801227, 7604.1635420103885, 7606.353459955896, 7611.657475413605, 7611.77164685059, 2238.7425446073667, 2260.9886950565224, 2263.366257447917, 2264.286749673856, 2265.3317271404976, 2262.7284725832924, 2280.441291883491, 2292.9656055159185, 2297.310806757974, 2298.184144628658, 2192.473806286496, 2210.270610698474, 2234.7876951689564, 2243.674667173259, 2249.7750224977535, 2221.0227499899993, 2260.0507786729613, 2271.057511132878, 2274.795268425841, 2275.4425165834396, 2209.2819833554, 2216.213244298283, 2219.8557093789013, 2221.7000704904794, 2223.7442694090223, 6452.483801295885, 6646.634435106067, 7568.924310756877, 7582.052243469567, 7597.924020759777, 4310.3534469829465, 4400.0, 4401.5598440156045, 4404.4934832494355, 4413.249747542925, 2912.4320757452306, 2998.175501737018, 3029.4849875521213, 3053.64883038449, 3067.0952069139657, 937.7374335186158, 941.6515889121, 982.4792859784326, 1012.1953047327393, 1016.207358260558, 10417.427041512714, 10488.895111048945, 10489.842652360221, 10490.370577765283, 10501.894981050245, 4100.753954762724, 4174.686898482565, 4180.749155050646, 4184.66522678185, 4222.0, 8934.50860202695, 8954.686585969459, 8963.193312601767, 8969.416987895765, 8974.37179397449, 4364.934525982113, 4373.6282415994365, 4392.648588112943, 4402.361657559636, 4407.294832826732, 3882.320593896057, 3907.0427745202037, 3915.7454765440157, 3916.373380259145, 3922.3332033554366, 3441.4493681010917, 3493.8427770750377, 3497.178163131662, 3499.4750787382095, 3518.7009104225917, 1150.3500522205095, 1153.3598852636867, 1153.7404084081184, 1157.3171828621155, 1173.8532683414574, 1302.4334414529521, 1307.3463268365817, 1328.5283724277742, 1332.0209645910247, 1341.5505805555053, 7133.857322853514, 7212.170600381023, 7224.385927196247, 7227.096612923385, 7270.818229544304, 456.50241237051773, 468.02183436617634, 469.85904228731243, 470.8493282149679, 474.5065132262408, 5044.8234311798915, 5594.524465420403, 5638.4925356718095, 5648.85877853057, 5654.434556544395, 7788.221177882167, 8695.260902823331, 8908.599113039929, 8961.686340978034, 9023.593938272794, 8720.389572729975, 8755.255803256667, 8767.780805479786, 8864.601092950832, 8876.644934202688, 6986.0, 7117.857642847114, 7159.176694680178, 7160.641967901584, 7163.212046674862, 6730.730770769114, 6850.417714494324, 6870.62211578368, 6878.69045892946, 6897.827554311182, 7848.254415830487, 8037.236462536283, 8070.515769053875, 8072.87890681652, 8073.031236251687, 8127.593620319079, 8186.222308880647, 8261.917380826115, 8342.165783421851, 8356.331493480386, 6724.8991265132045, 6756.0, 6765.797026089225, 6787.490938179558, 6805.9659701701175, 7301.671424785791, 7324.304191101837, 7344.339009489172, 7407.222241664763, 7419.183889772229, 6756.155480564929, 6943.236244013256, 7028.613426261605, 7040.0, 7149.571025738473, 6901.033855260167, 6923.792286231421, 6976.4767642426, 6980.336867997736, 6983.650817459208, 6927.168739751262, 6988.965055174692, 6993.965030174817, 6997.370236678723, 6999.370056694922, 6476.514261430506, 6494.058361537645, 6494.1232933553365, 6510.837229069121, 6514.478841692748, 6187.84530386744, 6265.310815810166, 6268.091126786499, 6275.623462592259, 6311.116443697978], "ext.html": [560.2428676773384, 579.0792639702872, 599.4724642314764, 601.8014055361731, 627.2441707742171, 31385.52921706176, 39865.60134398655, 40103.19793604133, 40171.59828401715, 40201.1959760805, 43734.0, 44487.110257794826, 44510.10979780411, 44538.77730611342, 44544.554554454444, 7653.961730191341, 7746.728864489744, 8692.869606955885, 9006.279497640173, 10273.794524109513, 10415.062644362006, 10461.320014199091, 10519.894801052007, 10525.736856578571, 10526.736831579195, 10491.73770655732, 10521.473926303692, 10564.524596393181, 10583.629572964948, 10588.311759735592, 7861.960690196541, 8050.677972881107, 10578.682639520826, 10804.243702940797, 10832.40421776802, 10370.585176592927, 10485.37087774736, 10491.790164196673, 10508.369497830077, 10509.106725928305, 39716.40425393621, 40079.0, 40108.799456002824, 40140.0, 40240.19519609591, 3032.605761251023, 3047.6495203051713, 3242.8864989725485, 3399.5920489541168, 3662.487251784752, 30284.54573181404, 30462.69537304643, 30466.84766576175, 30639.387212255853, 31506.212344691336, 3461.4769501419546, 3488.3546543889206, 3542.1321776164746, 3558.893233202982, 3691.9630803692157, 289630.0, 290985.0, 291092.0, 291545.0, 291911.0, 47843.76078119587, 48394.27408588874, 64694.0, 65555.68888622201, 65699.67150164218, 60632.0, 60811.0, 60850.0, 60894.0, 61036.69481652652, 12868.613941581767, 12945.0, 12952.546660867012, 12971.41628626714, 12984.545540906023, 10869.782604347869, 10909.563617455371, 10928.672139835817, 10938.507767150497, 10957.945210274058, 19148.0, 19212.0, 19331.226750929804, 19462.902685486766, 19488.415347539314, 7524.435667324972, 7715.884261736079, 7767.572783496849, 7791.532508049535, 7795.727149549739, 952.6808519146025, 1035.761774791787, 1040.2406243442329, 1100.4772732951944, 1118.0273162348647, 28618.0, 29007.70992290092, 29245.26886827804, 29407.85296073506, 34064.1483962898, 976.3946353260882, 1042.358949246208, 1062.6333914799382, 1064.5528877871159, 1186.7804456175636, 15593.766093508606, 15598.376064957502, 15711.371545138296, 15721.764173537405, 15839.683206335809, 388658.0, 389638.0, 394453.0, 395629.0, 395980.0, 54500.0, 55011.44988550143, 55043.72478137584, 55110.448895511334, 55122.44877551253, 1282.0961222338415, 1327.084311824857, 1384.9099808512415, 1390.958271251864, 1432.1621851216946, 23254.53490930138, 30857.382852343275, 30968.53547196839, 31194.532082019243, 31321.530177047818, 51083.0, 51802.740986294826, 51813.0, 51876.740616298186, 51902.74048629733, 306528.0, 307955.0, 308624.0, 391151.0, 399203.0, 32382.83808580942, 32699.0, 32809.83595082105, 33062.17344566405, 33200.1699957503, 39252.62615808433, 40064.59935400725, 40418.1916361677, 40616.593834061285, 40741.1851762969, 35972.0, 36002.45996310005, 36035.459468107474, 36172.0, 37336.253274933806, 36226.275474489834, 36619.0, 36834.0, 36858.8157059213, 36917.0, 40979.180416392104, 40990.0, 41150.58849411467, 41474.58525414828, 41679.58320416757, 32423.513647295782, 32450.83774581112, 35309.0, 35385.292294153456, 35429.0, 26373.208803735917, 26470.86764566242, 26554.867225663747, 26564.203073907815, 26889.865550672122], "prototype.html": [294.27608084113086, 295.23534046818736, 298.9925251868704, 299.3533966632074, 301.8566181063994, 5864.061750119981, 5971.31329897062, 5988.940110598893, 6001.039833626621, 6039.818805435833, 5828.300603927534, 5897.734601942912, 5898.1447690084915, 5900.498457631095, 5909.349971503131, 4260.297050986584, 4456.64346852251, 4464.486584042828, 4464.754438505881, 4465.062336909245, 4315.633171180438, 4328.740275583459, 4391.429114215163, 4397.12057588482, 4404.845830395937, 4270.0605866709275, 4294.763787991659, 4297.656187505007, 4309.762963037032, 4315.374270730742, 4156.189543039109, 4229.894252643678, 4281.250781113308, 4285.400043993844, 4311.827526898936, 3709.51776269086, 3719.144596742737, 3728.645778651051, 3732.216234590739, 3734.981325093357, 5545.667259964415, 5547.029269877755, 5550.611457197998, 5555.527780138693, 5572.0527510323345, 5043.268726034705, 5056.393232812049, 5058.785891386041, 5060.367454068241, 5060.898782024339, 6021.819345419644, 6173.722182501753, 6191.4118158774845, 6244.094606282064, 6250.0624906263965, 4161.459010328668, 4168.458100446923, 4169.4162817205615, 4170.332746760534, 4172.269852775782, 6486.383793539653, 6514.511411644098, 6559.901601475934, 6560.442362399202, 6567.179102612174, 4249.46881639795, 4256.851010214627, 4258.53156152823, 4259.765712885821, 4286.828526858953, 4222.683298752606, 4304.78476076195, 4306.461692288464, 4307.913841723211, 4327.069680018811, 5069.290299358093, 5070.873228169326, 5071.137906555894, 5071.771770270347, 5074.340335756328, 6295.653739044396, 6328.841778955563, 6330.746770129235, 6333.334999825044, 6341.587796793194, 1526.9465568705043, 1545.675408164298, 1546.5592306192682, 1547.2805145607347, 1547.984520154784, 988.2242439684813, 989.4953573677333, 994.6252553499551, 995.1889210293588, 1004.6132239087858, 6108.969455152695, 6114.0, 6116.113163591254, 6122.295935967331, 6122.479589234876, 6506.186726659168, 6508.8047358579315, 6511.706973186218, 6512.381323774234, 6520.15238019064, 5985.191999080155, 6096.0855871619615, 6101.206843110456, 6107.053406721965, 6108.908366374508, 3490.0227936177403, 3553.3959226931483, 3560.0, 3596.8381422836037, 3624.5106910567265, 6693.163354580677, 6718.49611279156, 6724.260331363546, 6733.494987875929, 6740.595564266159, 6487.383698548725, 6528.37980391862, 6565.80302590923, 6571.441427478718, 6619.834504137435, 6622.37087476689, 6688.565243259172, 6707.262201157869, 6734.595924244561, 6738.46092312604, 6487.026945958144, 6494.253160886558, 6494.350564943468, 6496.512761542997, 6509.251436084722, 6330.366963303817, 6378.936210637834, 6379.776707815204, 6383.808485745435, 6413.518986076157, 6572.211334639874, 6638.336166383323, 6678.799636010927, 6684.699188536625, 6707.128073350434, 4278.294081476522, 4321.027768752006, 4322.5677432256525, 4323.52441231458, 4329.328954012133, 6338.492920566436, 6378.075179099097, 6380.87238255223, 6390.105385245976, 6425.807225783234, 6207.410296021871, 6212.937870621236, 6224.533160013108, 6228.4705800007505, 6320.873582528416, 6298.968505157445, 6307.148534947723, 6308.716107775253, 6311.274203466476, 6313.210848643919, 6163.84590385244, 6177.073438984188, 6194.101855231056, 6198.039303907902, 6198.163247961467, 6181.1655426516845, 6276.529260305404, 6323.114763933145, 6337.397947195009, 6340.048992651139, 6212.689365531615, 6242.032484964838, 6252.124702541739, 6253.030780229072, 6253.874922501615], "yui.html": [754.6151462753994, 853.9786505337365, 855.4183155454289, 863.625031164298, 889.0487178718773, 13966.092204006745, 14236.71526569468, 14268.928655356709, 14287.785683214746, 14295.78556321656, 13048.217106973589, 13211.801822972662, 13242.602721918334, 13317.866821331783, 13412.26232557209, 808.7048227396987, 826.5371392020458, 827.3009307135461, 827.7765003449065, 828.5401602110826, 804.9557274349909, 812.175641723648, 815.592203898051, 816.2531283875247, 817.4441379861692, 845.3237410071948, 852.4970267542149, 857.8241460500583, 858.6822875536029, 860.0496451421184, 846.0946786937978, 847.2967437027253, 852.0882655558523, 852.6802449081595, 854.0264098927228, 628.9088082228097, 633.3444884544521, 633.8161933039413, 634.3497914637487, 634.9809505714836, 12441.066919981038, 12506.49974001039, 12519.3740312984, 12552.121351505399, 12555.497780088877, 10937.83593246102, 11003.889961100447, 11163.106951443864, 11242.943785281102, 11389.943050284779, 9592.66425675105, 9611.615535378576, 9880.270952583342, 10037.146842518394, 10051.798964020752, 3467.826608669556, 3559.537260156189, 3603.963960360389, 3609.5488063992, 3632.219072899339, 40870.79564602188, 41028.79485602583, 44002.0, 45349.773251133534, 46659.76670116662, 10399.792004159874, 10411.895881041244, 10426.0, 10506.054455099078, 10948.0, 16918.661626767396, 16930.830691692925, 16936.153192340334, 16943.91528042352, 18601.0, 7326.450516211199, 7402.555846649218, 7434.219406962191, 7509.436792240604, 7542.6605802739, 4147.91704165915, 4204.3903633972905, 4290.099079193405, 4292.678049146327, 4369.584889435562, 3025.6974302570006, 3064.586280852101, 3067.1565319536858, 3067.38652269547, 3069.4474994501206, 451.22164266640436, 455.210210285155, 503.94456609772897, 506.16482803374726, 524.9973750131302, 618.5639124417276, 650.2619526836979, 653.6829637625748, 692.5740669488329, 718.2279050021248, 8157.592120393957, 8348.457350272212, 8392.664293428317, 8433.493990360597, 8607.61265743043, 611.8164550634792, 614.9784757533465, 619.615838180322, 631.4380201620561, 658.7760161545098, 3975.503270700747, 4054.3715724062818, 4055.1484188320783, 4071.6539094176733, 4088.2845502037026, 58461.12308315294, 58743.41256587465, 59077.0, 59584.10623840559, 59685.70157149187, 52066.73966630142, 52859.0, 52914.73542632262, 52947.0, 53097.46902531003, 46647.533524665, 47089.29366059512, 47309.76345118252, 47750.0, 48524.51475485271, 7709.807254818675, 8037.879431808645, 8291.170882911661, 8751.868721969304, 8942.0, 33753.83123084369, 34253.48619770656, 34288.0, 34720.82639586786, 35049.29901401907, 46016.309755353024, 46359.3046104302, 46784.0, 46841.76579117219, 46935.0, 7585.0139481867, 8125.390595705464, 8131.878021829559, 8155.306798922158, 8452.873206901779, 11749.530018799152, 11919.225250358699, 12139.75720485603, 12214.938925305316, 12448.81326780081, 11143.219974602025, 11199.384033878216, 11294.830577541179, 11629.709257268298, 11943.940280298542, 11320.433978300887, 11458.255213411101, 11552.82670759956, 11736.76526469483, 11834.349110798988, 10510.369377837354, 10589.9470502647, 10755.300905441121, 10757.839288376546, 11550.88449115498, 9564.426134431957, 10028.598856045677, 10195.337303075275, 10268.691939241835, 10280.691579252634, 8927.285817134743, 9677.854832177663, 9781.902180978099, 9842.606295748375, 9845.310828241954]}, "summary": {"lowerIsBetter": false, "suite": 6802.139660403965, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7683.1546313596355, "unit": "ms", "value": 7683.1546313596355}, "dojo.html": {"lowerIsBetter": false, "filtered": 5421.954191090432, "unit": "ms", "value": 5421.954191090432}, "mootools.html": {"lowerIsBetter": false, "filtered": 4284.038008242039, "unit": "ms", "value": 4284.038008242039}, "ext.html": {"lowerIsBetter": false, "filtered": 19219.903294582007, "unit": "ms", "value": 19219.903294582007}, "prototype.html": {"lowerIsBetter": false, "filtered": 4652.590009695382, "unit": "ms", "value": 4652.590009695382}, "yui.html": {"lowerIsBetter": false, "filtered": 6206.3709212186195, "unit": "ms", "value": 6206.3709212186195}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-034"}, "testrun": {"date": 1447223377, "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": "20151110205155", "branch": "Mozilla-Inbound", "revision": "5ce07357c5f7e458b0b5cfe1daad8e8eb772f765"}}, {"talos_counters": {}, "results": {"audio-dft": [159.0, 160.0, 161.0, 159.0, 160.0, 161.0, 161.0, 164.0, 160.0, 161.0], "ai-astar": [109.0, 110.0, 105.0, 109.0, 110.0, 111.0, 101.0, 110.0, 112.0, 113.0], "imaging-gaussian-blur": [110.0, 111.0, 110.0, 111.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0], "audio-beat-detection": [148.0, 124.0, 149.0, 163.0, 125.0, 153.0, 153.0, 129.0, 169.0, 125.0], "json-stringify-tinderbox": [67.0, 67.0, 68.0, 67.0, 69.0, 67.0, 67.0, 67.0, 67.0, 68.0], "stanford-crypto-pbkdf2": [141.0, 140.0, 149.0, 150.0, 150.0, 149.0, 150.0, 149.0, 155.0, 139.0], "json-parse-financial": [58.0, 59.0, 60.0, 57.0, 57.0, 57.0, 58.0, 67.0, 56.0, 56.0], "stanford-crypto-sha256-iterative": [68.0, 67.0, 66.0, 66.0, 66.0, 67.0, 67.0, 65.0, 65.0, 66.0], "audio-fft": [72.0, 71.0, 80.0, 94.0, 71.0, 71.0, 72.0, 101.0, 90.0, 71.0], "imaging-darkroom": [146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0], "stanford-crypto-ccm": [120.0, 121.0, 114.0, 119.0, 115.0, 122.0, 118.0, 122.0, 125.0, 123.0], "audio-oscillator": [90.0, 91.0, 131.0, 91.0, 90.0, 90.0, 143.0, 89.0, 91.0, 135.0], "stanford-crypto-aes": [85.0, 83.0, 90.0, 84.0, 84.0, 86.0, 85.0, 84.0, 85.0, 86.0], "imaging-desaturate": [96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1492.2, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 79.3, "unit": "ms", "value": 79.3}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 147.2, "unit": "ms", "value": 147.2}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 143.8, "unit": "ms", "value": 143.8}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 119.9, "unit": "ms", "value": 119.9}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.7, "unit": "ms", "value": 145.7}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 58.5, "unit": "ms", "value": 58.5}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 104.1, "unit": "ms", "value": 104.1}, "ai-astar": {"lowerIsBetter": true, "filtered": 109.0, "unit": "ms", "value": 109.0}, "audio-dft": {"lowerIsBetter": true, "filtered": 160.6, "unit": "ms", "value": 160.6}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 66.3, "unit": "ms", "value": 66.3}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 67.4, "unit": "ms", "value": 67.4}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.8, "unit": "ms", "value": 109.8}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.2, "unit": "ms", "value": 85.2}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.4, "unit": "ms", "value": 95.4}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-034"}, "testrun": {"date": 1447223377, "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": "20151110205155", "branch": "Mozilla-Inbound", "revision": "5ce07357c5f7e458b0b5cfe1daad8e8eb772f765"}}, {"talos_counters": {}, "results": {"DeltaBlue": [194.3634596695821], "Encrypt": [287.4389192296637], "NavierStokes": [4835.748792270531], "Decrypt": [5045.226130653266], "Splay": [665.7789613848203], "Richards": [163.371998039536], "RegExp": [26315.78947368421], "Earley": [794.2811755361398], "Boyer": [11651.162790697674], "RayTrace": [1100.1100110011]}, "summary": {"lowerIsBetter": false, "suite": 20871.060442636946, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 340.1771100000001, "unit": "score", "value": 340.1771100000001}, "Encrypt": {"lowerIsBetter": false, "filtered": 926.0436990000001, "unit": "score", "value": 926.0436990000001}, "NavierStokes": {"lowerIsBetter": false, "filtered": 306.881118881119, "unit": "score", "value": 306.881118881119}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.75898306772911, "unit": "score", "value": 52.75898306772911}, "Splay": {"lowerIsBetter": false, "filtered": 122.39948199999999, "unit": "score", "value": 122.39948199999999}, "RegExp": {"lowerIsBetter": false, "filtered": 34.61742999999998, "unit": "score", "value": 34.61742999999998}, "Richards": {"lowerIsBetter": false, "filtered": 216.08354200000005, "unit": "score", "value": 216.08354200000005}, "Earley": {"lowerIsBetter": false, "filtered": 839.0769169999999, "unit": "score", "value": 839.0769169999999}, "Boyer": {"lowerIsBetter": false, "filtered": 57.20141516966067, "unit": "score", "value": 57.20141516966067}, "RayTrace": {"lowerIsBetter": false, "filtered": 672.6500009999999, "unit": "score", "value": 672.6500009999999}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-034"}, "testrun": {"date": 1447223377, "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": "20151110205155", "branch": "Mozilla-Inbound", "revision": "5ce07357c5f7e458b0b5cfe1daad8e8eb772f765"}}] 22:49:50 INFO - RETURN: dromaeo_css: 6802.14 22:49:50 INFO - RETURN: kraken: 1492.20 22:49:50 INFO - RETURN: v8_7: 20871.06 22:49:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "20871.06"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1492.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6802.14"}}} 22:49:50 INFO - Return code: 0 22:49:50 INFO - # TBPL SUCCESS # 22:49:50 INFO - Running post-action listener: _resource_record_post_action 22:49:50 INFO - Running post-run listener: _resource_record_post_run 22:49:51 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 527593472; Read time: 36; Write time: 555852 22:49:51 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 241766400; Read time: 0; Write time: 302084 22:49:51 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 281595904; Read time: 36; Write time: 185232 22:49:51 INFO - Running post-run listener: _upload_blobber_files 22:49:51 INFO - Blob upload gear active. 22:49:51 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:49:51 INFO - Copying logs to upload dir... 22:49:51 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1260.895225 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2015-11-10 22:49:51.485803) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-10 22:49:51.489566) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1447222890.726413-970869175 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/5P9uH1O7RN21C9C5dVrOYA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009891 build_url: 'https://queue.taskcluster.net/v1/task/5P9uH1O7RN21C9C5dVrOYA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-10 22:49:51.540214) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 22:49:51.540537) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1447222890.726413-970869175 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004677 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 22:49:51.589981) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-10 22:49:51.590329) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-10 22:49:51.590625) ========= ========= Total master_lag: 0.21 =========