builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1445604793.59 results: success (0) buildid: 20151023030245 builduid: 8f15600a08b64a3bba8fecea4768a911 revision: 0625c68c0abcfe4d10880d15d8fe7d06df3369c9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-23 05:53:13.588513) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-23 05:53:13.589081) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-23 05:53:13.589396) ========= 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=7f67ac1ceef7774224e327f2000001f6-1445602380.562456-627290231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004387 basedir: '/builds/slave/test-pgo' ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-23 05:53:13.635938) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-23 05:53:13.636277) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-23 05:53:13.673795) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-23 05:53:13.674171) ========= 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=7f67ac1ceef7774224e327f2000001f6-1445602380.562456-627290231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.038658 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-23 05:53:13.728015) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-23 05:53:13.728385) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-23 05:53:13.728791) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-23 05:53:13.729116) ========= 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=7f67ac1ceef7774224e327f2000001f6-1445602380.562456-627290231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-10-23 05:53:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2015-10-23 05:53:14 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.952847 ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-23 05:53:14.876664) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-23 05:53:14.876969) ========= 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=7f67ac1ceef7774224e327f2000001f6-1445602380.562456-627290231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.092083 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-23 05:53:14.986658) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2015-10-23 05:53:14.987035) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0625c68c0abcfe4d10880d15d8fe7d06df3369c9 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0625c68c0abcfe4d10880d15d8fe7d06df3369c9 --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=7f67ac1ceef7774224e327f2000001f6-1445602380.562456-627290231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-10-23 05:53:15,006 truncating revision to first 12 chars 2015-10-23 05:53:15,006 Setting DEBUG logging. 2015-10-23 05:53:15,006 attempt 1/10 2015-10-23 05:53:15,006 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0625c68c0abc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-23 05:53:16,347 unpacking tar archive at: mozilla-central-0625c68c0abc/testing/mozharness/ program finished with exit code 0 elapsedTime=2.636012 ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2015-10-23 05:53:18.284751) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-23 05:53:18.285451) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-23 05:53:18.304449) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-23 05:53:18.304757) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-23 05:53:18.305201) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 59 secs) (at 2015-10-23 05:53:18.305491) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=7f67ac1ceef7774224e327f2000001f6-1445602380.562456-627290231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:53:18 INFO - MultiFileLogger online at 20151023 05:53:18 in /builds/slave/test-pgo 05:53:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:53:18 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:53:18 INFO - {'append_to_log': False, 05:53:18 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:53:18 INFO - 'blob_upload_branch': 'Firefox', 05:53:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:53:18 INFO - 'branch': 'Firefox', 05:53:18 INFO - 'buildbot_json_path': 'buildprops.json', 05:53:18 INFO - 'config_files': ('talos/linux_config.py',), 05:53:18 INFO - 'default_actions': ('clobber', 05:53:18 INFO - 'read-buildbot-config', 05:53:18 INFO - 'download-and-extract', 05:53:18 INFO - 'populate-webroot', 05:53:18 INFO - 'create-virtualenv', 05:53:18 INFO - 'install', 05:53:18 INFO - 'run-tests'), 05:53:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:53:18 INFO - 'download_minidump_stackwalk': True, 05:53:18 INFO - 'download_symbols': 'ondemand', 05:53:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:53:18 INFO - 'tooltool.py': '/tools/tooltool.py', 05:53:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:53:18 INFO - '/tools/misc-python/virtualenv.py')}, 05:53:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:53:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:53:18 INFO - 'installer_path': 'installer.exe', 05:53:18 INFO - 'log_level': 'info', 05:53:18 INFO - 'log_name': 'talos', 05:53:18 INFO - 'log_to_console': True, 05:53:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:53:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:53:18 INFO - 'opt_config_files': (), 05:53:18 INFO - 'pip_index': False, 05:53:18 INFO - 'sps_profile': False, 05:53:18 INFO - 'sps_profile_interval': 0, 05:53:18 INFO - 'suite': 'dromaeojs', 05:53:18 INFO - 'system_bits': '64', 05:53:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:53:18 INFO - 'title': 'talos-linux64-ix-041', 05:53:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:53:18 INFO - 'use_talos_json': True, 05:53:18 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:53:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:53:18 INFO - 'work_dir': 'build'} 05:53:18 INFO - ##### 05:53:18 INFO - ##### Running clobber step. 05:53:18 INFO - ##### 05:53:18 INFO - Running pre-action listener: _resource_record_pre_action 05:53:18 INFO - Running main action method: clobber 05:53:18 INFO - rmtree: /builds/slave/test-pgo/build 05:53:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:53:19 INFO - Running post-action listener: _resource_record_post_action 05:53:19 INFO - ##### 05:53:19 INFO - ##### Running read-buildbot-config step. 05:53:19 INFO - ##### 05:53:19 INFO - Running pre-action listener: _resource_record_pre_action 05:53:19 INFO - Running main action method: read_buildbot_config 05:53:19 INFO - Using buildbot properties: 05:53:19 INFO - { 05:53:19 INFO - "properties": { 05:53:19 INFO - "buildnumber": 507, 05:53:19 INFO - "product": "firefox", 05:53:19 INFO - "script_repo_revision": "production", 05:53:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:53:19 INFO - "repository": "", 05:53:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:53:19 INFO - "buildid": "20151023030245", 05:53:19 INFO - "slavename": "talos-linux64-ix-041", 05:53:19 INFO - "stage_platform": "linux64-pgo", 05:53:19 INFO - "basedir": "/builds/slave/test-pgo", 05:53:19 INFO - "nightly_build": "True", 05:53:19 INFO - "project": "", 05:53:19 INFO - "platform": "ubuntu64_hw", 05:53:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:53:19 INFO - "slavebuilddir": "test", 05:53:19 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:53:19 INFO - "branch": "mozilla-central", 05:53:19 INFO - "repo_path": "mozilla-central", 05:53:19 INFO - "pgo_build": "True", 05:53:19 INFO - "builduid": "8f15600a08b64a3bba8fecea4768a911", 05:53:19 INFO - "revision": "0625c68c0abcfe4d10880d15d8fe7d06df3369c9" 05:53:19 INFO - }, 05:53:19 INFO - "sourcestamp": { 05:53:19 INFO - "repository": "", 05:53:19 INFO - "hasPatch": false, 05:53:19 INFO - "project": "", 05:53:19 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:53:19 INFO - "changes": [ 05:53:19 INFO - { 05:53:19 INFO - "category": null, 05:53:19 INFO - "files": [ 05:53:19 INFO - { 05:53:19 INFO - "url": null, 05:53:19 INFO - "name": "https://queue.taskcluster.net/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2" 05:53:19 INFO - } 05:53:19 INFO - ], 05:53:19 INFO - "repository": "", 05:53:19 INFO - "rev": "0625c68c0abcfe4d10880d15d8fe7d06df3369c9", 05:53:19 INFO - "who": "sendchange", 05:53:19 INFO - "when": 1445604643, 05:53:19 INFO - "number": 6565888, 05:53:19 INFO - "comments": "", 05:53:19 INFO - "project": "", 05:53:19 INFO - "at": "Fri 23 Oct 2015 05:50:43", 05:53:19 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:53:19 INFO - "revlink": "", 05:53:19 INFO - "properties": [ 05:53:19 INFO - [ 05:53:19 INFO - "buildid", 05:53:19 INFO - "20151023030245", 05:53:19 INFO - "Change" 05:53:19 INFO - ], 05:53:19 INFO - [ 05:53:19 INFO - "builduid", 05:53:19 INFO - "8f15600a08b64a3bba8fecea4768a911", 05:53:19 INFO - "Change" 05:53:19 INFO - ], 05:53:19 INFO - [ 05:53:19 INFO - "nightly_build", 05:53:19 INFO - "True", 05:53:19 INFO - "Change" 05:53:19 INFO - ], 05:53:19 INFO - [ 05:53:19 INFO - "pgo_build", 05:53:19 INFO - "True", 05:53:19 INFO - "Change" 05:53:19 INFO - ] 05:53:19 INFO - ], 05:53:19 INFO - "revision": "0625c68c0abcfe4d10880d15d8fe7d06df3369c9" 05:53:19 INFO - } 05:53:19 INFO - ], 05:53:19 INFO - "revision": "0625c68c0abcfe4d10880d15d8fe7d06df3369c9" 05:53:19 INFO - } 05:53:19 INFO - } 05:53:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2. 05:53:19 INFO - Running post-action listener: _resource_record_post_action 05:53:19 INFO - ##### 05:53:19 INFO - ##### Running download-and-extract step. 05:53:19 INFO - ##### 05:53:19 INFO - Running pre-action listener: _resource_record_pre_action 05:53:19 INFO - Running main action method: download_and_extract 05:53:19 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:53: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')]} 05:53:19 INFO - https://queue.taskcluster.net/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:53:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/test_packages.json 05:53:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/test_packages.json 05:53:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:53:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:53:21 INFO - Downloaded 1302 bytes. 05:53:21 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:53:21 INFO - Using the following test package requirements: 05:53:21 INFO - {u'common': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'], 05:53:21 INFO - u'cppunittest': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:21 INFO - u'firefox-44.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:53:21 INFO - u'jittest': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:21 INFO - u'jsshell-linux-x86_64.zip'], 05:53:21 INFO - u'mochitest': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:21 INFO - u'firefox-44.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:53:21 INFO - u'mozbase': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'], 05:53:21 INFO - u'reftest': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:21 INFO - u'firefox-44.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:53:21 INFO - u'talos': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:21 INFO - u'firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:53:21 INFO - u'web-platform': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:21 INFO - u'firefox-44.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:53:21 INFO - u'webapprt': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'], 05:53:21 INFO - u'xpcshell': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:21 INFO - u'firefox-44.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:53:21 INFO - Downloading packages: [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:53:21 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')]} 05:53:21 INFO - https://queue.taskcluster.net/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:53:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 05:53:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 05:53:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 05:53:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:53:24 INFO - Downloaded 23947917 bytes. 05:53:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:53:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 05:53:24 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:53:25 INFO - Return code: 0 05:53:25 INFO - Downloading packages: [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:53:25 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')]} 05:53:25 INFO - https://queue.taskcluster.net/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:53:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 05:53:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 05:53:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 05:53:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:53:44 INFO - Downloaded 23947917 bytes. 05:53:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:53:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 05:53:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:53:46 INFO - Return code: 0 05:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:46 INFO - https://queue.taskcluster.net/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:53:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip 05:53:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip 05:53:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip 05:53:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:53:54 INFO - Downloaded 11131307 bytes. 05:53:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 05:53:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip 05:53:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:53:54 INFO - Return code: 0 05:53: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')]} 05:53:54 INFO - https://queue.taskcluster.net/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:53:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 05:53:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 05:53:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 05:53:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:54:07 INFO - Downloaded 57118122 bytes. 05:54:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 05:54:07 INFO - mkdir: /builds/slave/test-pgo/properties 05:54:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:54:07 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:54:07 INFO - Contents: 05:54:07 INFO - build_url:https://queue.taskcluster.net/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 05:54:07 INFO - Running post-action listener: _resource_record_post_action 05:54:07 INFO - Running post-action listener: set_extra_try_arguments 05:54:07 INFO - ##### 05:54:07 INFO - ##### Running populate-webroot step. 05:54:07 INFO - ##### 05:54:07 INFO - Running pre-action listener: _resource_record_pre_action 05:54:07 INFO - Running main action method: populate_webroot 05:54:07 INFO - Guessing talos json url... 05:54: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')]} 05:54:07 INFO - https://queue.taskcluster.net/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.txt matches https://queue.taskcluster.net 05:54:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.txt 05:54:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.txt 05:54:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.txt to /builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.txt 05:54:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.txt', 'file_name': '/builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.txt'}, attempt #1 05:54:08 INFO - Downloaded 99 bytes. 05:54:08 INFO - Reading from file /builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.txt 05:54:08 INFO - Contents: 05:54:08 INFO - 20151023030245 05:54:08 INFO - https://hg.mozilla.org/mozilla-central/rev/0625c68c0abcfe4d10880d15d8fe7d06df3369c9 05:54: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')]} 05:54:08 INFO - trying https://hg.mozilla.org/mozilla-central/raw-file/0625c68c0a/testing/talos/talos.json 05:54:08 INFO - Downloading https://hg.mozilla.org/mozilla-central/raw-file/0625c68c0a/testing/talos/talos.json to /builds/slave/test-pgo/build/talos.json 05:54:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/mozilla-central/raw-file/0625c68c0a/testing/talos/talos.json', 'file_name': '/builds/slave/test-pgo/build/talos.json'}, attempt #1 05:54:09 INFO - Downloaded 4264 bytes. 05:54:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:54:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:54:09 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:54:09 INFO - '../fennec_ids.txt'], 05:54:09 INFO - 'tests': ['tcheck2']}, 05:54:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:54:09 INFO - '--tppagecycles', 05:54:09 INFO - '7'], 05:54:09 INFO - 'tests': ['tsvgm']}}, 05:54:09 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:54:09 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:54:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:54:09 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:54:09 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:54:09 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:54:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:09 INFO - 'talos_options': ['--e10s'], 05:54:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:09 INFO - 'tests': ['damp', 'tps']}, 05:54:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:09 INFO - 'talos_options': ['--e10s'], 05:54:09 INFO - 'tests': ['damp', 'tps']}, 05:54:09 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:54:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:54:09 INFO - 'other': {'tests': ['a11yr', 05:54:09 INFO - 'ts_paint', 05:54:09 INFO - 'tpaint', 05:54:09 INFO - 'sessionrestore', 05:54:09 INFO - 'sessionrestore_no_auto_restore']}, 05:54:09 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:54:09 INFO - 'tests': ['a11yr', 05:54:09 INFO - 'ts_paint', 05:54:09 INFO - 'tpaint', 05:54:09 INFO - 'sessionrestore', 05:54:09 INFO - 'sessionrestore_no_auto_restore']}, 05:54:09 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:54:09 INFO - 'tests': ['a11yr', 05:54:09 INFO - 'ts_paint', 05:54:09 INFO - 'tpaint', 05:54:09 INFO - 'sessionrestore', 05:54:09 INFO - 'sessionrestore_no_auto_restore']}, 05:54:09 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:54:09 INFO - 'tests': ['a11yr', 05:54:09 INFO - 'ts_paint', 05:54:09 INFO - 'tpaint', 05:54:09 INFO - 'sessionrestore', 05:54:09 INFO - 'sessionrestore_no_auto_restore']}, 05:54:09 INFO - 'other_l64': {'tests': ['a11yr', 05:54:09 INFO - 'ts_paint', 05:54:09 INFO - 'tpaint', 05:54:09 INFO - 'sessionrestore', 05:54:09 INFO - 'sessionrestore_no_auto_restore']}, 05:54:09 INFO - 'other_nol64': {'tests': ['a11yr', 05:54:09 INFO - 'ts_paint', 05:54:09 INFO - 'tpaint', 05:54:09 INFO - 'sessionrestore', 05:54:09 INFO - 'sessionrestore_no_auto_restore']}, 05:54:09 INFO - 'svgr': {'tests': ['tsvgx', 05:54:09 INFO - 'tsvgr_opacity', 05:54:09 INFO - 'tart', 05:54:09 INFO - 'tscrollx', 05:54:09 INFO - 'cart']}, 05:54:09 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:54:09 INFO - 'tests': ['tsvgx', 05:54:09 INFO - 'tsvgr_opacity', 05:54:09 INFO - 'tart', 05:54:09 INFO - 'tscrollx', 05:54:09 INFO - 'cart']}, 05:54:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:09 INFO - 'tests': ['tp5o']}, 05:54:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:09 INFO - 'talos_options': ['--e10s'], 05:54:09 INFO - 'tests': ['tp5o']}, 05:54:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:09 INFO - 'talos_options': ['--xperf_path', 05:54:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:54:09 INFO - 'tests': ['tp5n']}, 05:54:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:09 INFO - 'talos_options': ['--e10s', 05:54:09 INFO - '--xperf_path', 05:54:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 05:54:09 INFO - 'C:/slave/talos-data/talos/xperf.config'], 05:54:09 INFO - 'tests': ['tp5n']}}, 05:54:09 INFO - 'talos.zip': {'path': '', 05:54:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:54:09 INFO - Running post-action listener: _resource_record_post_action 05:54:09 INFO - ##### 05:54:09 INFO - ##### Running create-virtualenv step. 05:54:09 INFO - ##### 05:54:09 INFO - Running pre-action listener: _resource_record_pre_action 05:54:09 INFO - Running main action method: create_virtualenv 05:54:09 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:54:09 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 05:54:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:54:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:54:09 INFO - Using real prefix '/usr' 05:54:09 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:54:10 INFO - Installing distribute.............................................................................................................................................................................................done. 05:54:12 INFO - Installing pip.................done. 05:54:12 INFO - Return code: 0 05:54:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:54: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')]} 05:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54: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')]} 05:54:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f35ec832c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ae7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1888c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bf230>, '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 0x19116c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1911b70>, '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': '7f67ac1ceef7774224e327f2000001f6-1445602380.562456-627290231', '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 05:54: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:54: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 pip>=1.5 05:54:12 INFO - Using env: {'DISPLAY': ':0', 05:54:12 INFO - 'HOME': '/home/cltbld', 05:54:12 INFO - 'LANG': 'en_US.UTF-8', 05:54:12 INFO - 'LANGUAGE': 'en_US:en', 05:54:12 INFO - 'LOGNAME': 'cltbld', 05:54:12 INFO - 'MAIL': '/var/mail/cltbld', 05:54:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:12 INFO - 'MOZ_NO_REMOTE': '1', 05:54:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:12 INFO - 'NO_EM_RESTART': '1', 05:54:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:54:12 INFO - 'PWD': '/builds/slave/test-pgo', 05:54:12 INFO - 'SHELL': '/bin/bash', 05:54:12 INFO - 'SHLVL': '1', 05:54:12 INFO - 'TERM': 'linux', 05:54:12 INFO - 'TMOUT': '86400', 05:54:12 INFO - 'USER': 'cltbld', 05:54:12 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1445602380.562456-627290231', 05:54:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:12 INFO - '_': '/tools/buildbot/bin/python'} 05:54:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:12 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 05:54:12 INFO - Cleaning up... 05:54:12 INFO - Return code: 0 05:54:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:54: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')]} 05:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54: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')]} 05:54:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54: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', '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 0x7f35ec832c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ae7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1888c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bf230>, '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 0x19116c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1911b70>, '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': '7f67ac1ceef7774224e327f2000001f6-1445602380.562456-627290231', '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 05:54: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:54: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 psutil>=0.7.1 05:54:12 INFO - Using env: {'DISPLAY': ':0', 05:54:12 INFO - 'HOME': '/home/cltbld', 05:54:12 INFO - 'LANG': 'en_US.UTF-8', 05:54:12 INFO - 'LANGUAGE': 'en_US:en', 05:54:12 INFO - 'LOGNAME': 'cltbld', 05:54:12 INFO - 'MAIL': '/var/mail/cltbld', 05:54:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:12 INFO - 'MOZ_NO_REMOTE': '1', 05:54:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:12 INFO - 'NO_EM_RESTART': '1', 05:54:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:54:12 INFO - 'PWD': '/builds/slave/test-pgo', 05:54:12 INFO - 'SHELL': '/bin/bash', 05:54:12 INFO - 'SHLVL': '1', 05:54:12 INFO - 'TERM': 'linux', 05:54:12 INFO - 'TMOUT': '86400', 05:54:12 INFO - 'USER': 'cltbld', 05:54:12 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1445602380.562456-627290231', 05:54:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:12 INFO - '_': '/tools/buildbot/bin/python'} 05:54:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:13 INFO - Downloading/unpacking psutil>=0.7.1 05:54:13 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 05:54:13 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 05:54:13 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 05:54:13 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 05:54:13 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 05:54:13 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 05:54:17 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:54:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:54:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:54:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:17 INFO - Installing collected packages: psutil 05:54:17 INFO - Running setup.py install for psutil 05:54:17 INFO - building 'psutil._psutil_linux' extension 05:54:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:54:18 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 05:54:18 INFO - building 'psutil._psutil_posix' extension 05:54:18 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 05:54:18 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 05:54:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:19 INFO - Successfully installed psutil 05:54:19 INFO - Cleaning up... 05:54:19 INFO - Return code: 0 05:54:19 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:54: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')]} 05:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54: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')]} 05:54:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54: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', '--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 0x7f35ec832c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ae7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1888c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bf230>, '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 0x19116c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1911b70>, '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': '7f67ac1ceef7774224e327f2000001f6-1445602380.562456-627290231', '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 05:54:19 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 05:54:19 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 05:54:19 INFO - Using env: {'DISPLAY': ':0', 05:54:19 INFO - 'HOME': '/home/cltbld', 05:54:19 INFO - 'LANG': 'en_US.UTF-8', 05:54:19 INFO - 'LANGUAGE': 'en_US:en', 05:54:19 INFO - 'LOGNAME': 'cltbld', 05:54:19 INFO - 'MAIL': '/var/mail/cltbld', 05:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:19 INFO - 'MOZ_NO_REMOTE': '1', 05:54:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:19 INFO - 'NO_EM_RESTART': '1', 05:54:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:54:19 INFO - 'PWD': '/builds/slave/test-pgo', 05:54:19 INFO - 'SHELL': '/bin/bash', 05:54:19 INFO - 'SHLVL': '1', 05:54:19 INFO - 'TERM': 'linux', 05:54:19 INFO - 'TMOUT': '86400', 05:54:19 INFO - 'USER': 'cltbld', 05:54:19 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1445602380.562456-627290231', 05:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:19 INFO - '_': '/tools/buildbot/bin/python'} 05:54:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:19 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:54:19 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 05:54:19 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 05:54:19 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 05:54:19 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 05:54:19 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 05:54:19 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 05:54:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:54:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:54:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:54:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:54:25 INFO - Installing collected packages: mozsystemmonitor 05:54:25 INFO - Running setup.py install for mozsystemmonitor 05:54:25 INFO - Successfully installed mozsystemmonitor 05:54:25 INFO - Cleaning up... 05:54:25 INFO - Return code: 0 05:54:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:54:25 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')]} 05:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:25 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')]} 05:54:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:25 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 0x7f35ec832c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ae7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1888c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bf230>, '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 0x19116c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1911b70>, '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': '7f67ac1ceef7774224e327f2000001f6-1445602380.562456-627290231', '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 05:54:25 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 05:54:25 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 05:54:25 INFO - Using env: {'DISPLAY': ':0', 05:54:25 INFO - 'HOME': '/home/cltbld', 05:54:25 INFO - 'LANG': 'en_US.UTF-8', 05:54:25 INFO - 'LANGUAGE': 'en_US:en', 05:54:25 INFO - 'LOGNAME': 'cltbld', 05:54:25 INFO - 'MAIL': '/var/mail/cltbld', 05:54:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:25 INFO - 'MOZ_NO_REMOTE': '1', 05:54:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:25 INFO - 'NO_EM_RESTART': '1', 05:54:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:54:25 INFO - 'PWD': '/builds/slave/test-pgo', 05:54:25 INFO - 'SHELL': '/bin/bash', 05:54:25 INFO - 'SHLVL': '1', 05:54:25 INFO - 'TERM': 'linux', 05:54:25 INFO - 'TMOUT': '86400', 05:54:25 INFO - 'USER': 'cltbld', 05:54:25 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1445602380.562456-627290231', 05:54:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:25 INFO - '_': '/tools/buildbot/bin/python'} 05:54:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:25 INFO - Downloading/unpacking blobuploader==1.2.4 05:54:25 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 05:54:25 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 05:54:25 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 05:54:25 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 05:54:25 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 05:54:25 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 05:56:28 INFO - Cleaning up... 05:56:28 INFO - Exception: 05:56:28 ERROR - Traceback (most recent call last): 05:56:28 INFO - File "/builds/slave/test-pgo/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/basecommand.py", line 122, in main 05:56:28 INFO - status = self.run(options, args) 05:56:28 INFO - File "/builds/slave/test-pgo/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/commands/install.py", line 278, in run 05:56:28 INFO - requirement_set.prepare_files(finder, force_root_egg_info=self.bundle, bundle=self.bundle) 05:56:28 INFO - File "/builds/slave/test-pgo/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/req.py", line 1177, in prepare_files 05:56:28 INFO - url = finder.find_requirement(req_to_install, upgrade=self.upgrade) 05:56:28 INFO - File "/builds/slave/test-pgo/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/index.py", line 252, in find_requirement 05:56:28 INFO - for page in self._get_pages(locations, req): 05:56:28 INFO - File "/builds/slave/test-pgo/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/index.py", line 387, in _get_pages 05:56:28 INFO - page = self._get_page(location, req) 05:56:28 INFO - File "/builds/slave/test-pgo/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/index.py", line 568, in _get_page 05:56:28 INFO - session=self.session, 05:56:28 INFO - File "/builds/slave/test-pgo/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/index.py", line 670, in get_page 05:56:28 INFO - resp = session.get(url, headers={"Accept": "text/html"}) 05:56:28 INFO - File "/builds/slave/test-pgo/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/_vendor/requests/sessions.py", line 395, in get 05:56:28 INFO - return self.request('GET', url, **kwargs) 05:56:28 INFO - File "/builds/slave/test-pgo/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/download.py", line 237, in request 05:56:28 INFO - return super(PipSession, self).request(method, url, *args, **kwargs) 05:56:28 INFO - File "/builds/slave/test-pgo/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/_vendor/requests/sessions.py", line 383, in request 05:56:28 INFO - resp = self.send(prep, **send_kwargs) 05:56:28 INFO - File "/builds/slave/test-pgo/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/_vendor/requests/sessions.py", line 506, in send 05:56:28 INFO - history = [resp for resp in gen] if allow_redirects else [] 05:56:28 INFO - File "/builds/slave/test-pgo/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/_vendor/requests/sessions.py", line 168, in resolve_redirects 05:56:28 INFO - allow_redirects=False, 05:56:28 INFO - File "/builds/slave/test-pgo/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/_vendor/requests/sessions.py", line 486, in send 05:56:28 INFO - r = adapter.send(request, **kwargs) 05:56:28 INFO - File "/builds/slave/test-pgo/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/_vendor/requests/adapters.py", line 394, in send 05:56:28 INFO - r.content 05:56:28 INFO - File "/builds/slave/test-pgo/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/_vendor/requests/models.py", line 679, in content 05:56:28 INFO - self._content = bytes().join(self.iter_content(CONTENT_CHUNK_SIZE)) or bytes() 05:56:28 INFO - File "/builds/slave/test-pgo/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/_vendor/requests/models.py", line 616, in generate 05:56:28 INFO - decode_content=True): 05:56:28 INFO - File "/builds/slave/test-pgo/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/_vendor/requests/packages/urllib3/response.py", line 236, in stream 05:56:28 INFO - data = self.read(amt=amt, decode_content=decode_content) 05:56:28 INFO - File "/builds/slave/test-pgo/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/_vendor/requests/packages/urllib3/response.py", line 183, in read 05:56:28 INFO - data = self._fp.read(amt) 05:56:28 INFO - File "/usr/lib/python2.7/httplib.py", line 541, in read 05:56:28 INFO - return self._read_chunked(amt) 05:56:28 INFO - File "/usr/lib/python2.7/httplib.py", line 601, in _read_chunked 05:56:28 INFO - value.append(self._safe_read(chunk_left)) 05:56:28 INFO - File "/usr/lib/python2.7/httplib.py", line 647, in _safe_read 05:56:28 INFO - chunk = self.fp.read(min(amt, MAXAMOUNT)) 05:56:28 INFO - File "/usr/lib/python2.7/socket.py", line 380, in read 05:56:28 INFO - data = self._sock.recv(left) 05:56:28 INFO - timeout: timed out 05:56:28 INFO - Storing debug log for failure in /home/cltbld/.pip/pip.log 05:56:28 WARNING - Return code: 2 05:56:28 INFO - retry: Failed, sleeping 60 seconds before retrying 05:57:28 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 0x7f35ec832c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ae7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1888c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bf230>, '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 0x19116c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1911b70>, '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': '7f67ac1ceef7774224e327f2000001f6-1445602380.562456-627290231', '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 #2 05:57:28 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 05:57:28 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 05:57:28 INFO - Using env: {'DISPLAY': ':0', 05:57:28 INFO - 'HOME': '/home/cltbld', 05:57:28 INFO - 'LANG': 'en_US.UTF-8', 05:57:28 INFO - 'LANGUAGE': 'en_US:en', 05:57:28 INFO - 'LOGNAME': 'cltbld', 05:57:28 INFO - 'MAIL': '/var/mail/cltbld', 05:57:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:28 INFO - 'MOZ_NO_REMOTE': '1', 05:57:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:28 INFO - 'NO_EM_RESTART': '1', 05:57:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:57:28 INFO - 'PWD': '/builds/slave/test-pgo', 05:57:28 INFO - 'SHELL': '/bin/bash', 05:57:28 INFO - 'SHLVL': '1', 05:57:28 INFO - 'TERM': 'linux', 05:57:28 INFO - 'TMOUT': '86400', 05:57:28 INFO - 'USER': 'cltbld', 05:57:28 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1445602380.562456-627290231', 05:57:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:28 INFO - '_': '/tools/buildbot/bin/python'} 05:57:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:28 INFO - Downloading/unpacking blobuploader==1.2.4 05:57:28 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 05:57:28 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 05:57:28 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 05:57:28 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 05:57:28 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 05:57:28 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 05:57:33 INFO - Downloading blobuploader-1.2.4.tar.gz 05:57:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:57:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:57:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:57:33 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 05:57:33 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 05:57:33 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 05:57:33 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 05:57:33 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 05:57:33 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 05:57:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:57:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:57:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:57:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:35 INFO - Downloading docopt-0.6.1.tar.gz 05:57:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:57:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:57:35 INFO - Installing collected packages: blobuploader, requests, docopt 05:57:35 INFO - Running setup.py install for blobuploader 05:57:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:57:35 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:57:35 INFO - Running setup.py install for requests 05:57:36 INFO - Running setup.py install for docopt 05:57:36 INFO - Successfully installed blobuploader requests docopt 05:57:36 INFO - Cleaning up... 05:57:36 INFO - Return code: 0 05:57:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:57:36 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')]} 05:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:36 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')]} 05:57:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:36 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 0x7f35ec832c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ae7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1888c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bf230>, '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 0x19116c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1911b70>, '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': '7f67ac1ceef7774224e327f2000001f6-1445602380.562456-627290231', '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 05:57:36 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 05:57:36 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 05:57:36 INFO - Using env: {'DISPLAY': ':0', 05:57:36 INFO - 'HOME': '/home/cltbld', 05:57:36 INFO - 'LANG': 'en_US.UTF-8', 05:57:36 INFO - 'LANGUAGE': 'en_US:en', 05:57:36 INFO - 'LOGNAME': 'cltbld', 05:57:36 INFO - 'MAIL': '/var/mail/cltbld', 05:57:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:36 INFO - 'MOZ_NO_REMOTE': '1', 05:57:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:36 INFO - 'NO_EM_RESTART': '1', 05:57:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:57:36 INFO - 'PWD': '/builds/slave/test-pgo', 05:57:36 INFO - 'SHELL': '/bin/bash', 05:57:36 INFO - 'SHLVL': '1', 05:57:36 INFO - 'TERM': 'linux', 05:57:36 INFO - 'TMOUT': '86400', 05:57:36 INFO - 'USER': 'cltbld', 05:57:36 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1445602380.562456-627290231', 05:57:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:36 INFO - '_': '/tools/buildbot/bin/python'} 05:57:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:57:36 INFO - Running setup.py (path:/tmp/pip-IIEYlP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:57:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:57:36 INFO - Running setup.py (path:/tmp/pip-qU1KEF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:57:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:57:36 INFO - Running setup.py (path:/tmp/pip-iY6Al_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:57:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:57:36 INFO - Running setup.py (path:/tmp/pip-nSCztm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:57:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:57:36 INFO - Running setup.py (path:/tmp/pip-MACLUk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:57:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:57:36 INFO - Running setup.py (path:/tmp/pip-3Ziwu3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:57:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:57:36 INFO - Running setup.py (path:/tmp/pip-gLoDxL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:57:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:57:36 INFO - Running setup.py (path:/tmp/pip-rYzYHL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:57:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:57:37 INFO - Running setup.py (path:/tmp/pip-lzZRyB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:57:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:57:37 INFO - Running setup.py (path:/tmp/pip-KUtZxo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:57:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:57:37 INFO - Running setup.py (path:/tmp/pip-GK0_V0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:57:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:57:37 INFO - Running setup.py (path:/tmp/pip-m6j9pN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:57:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:57:37 INFO - Running setup.py (path:/tmp/pip-XcwSvm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:57:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:57:37 INFO - Running setup.py (path:/tmp/pip-4A2U1o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:57:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:57:37 INFO - Running setup.py (path:/tmp/pip-h4mxv8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:57:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:57:37 INFO - Running setup.py (path:/tmp/pip-wrjm6v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:57:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:57:37 INFO - Running setup.py (path:/tmp/pip-lkMtBU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:57:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:57:37 INFO - Running setup.py install for manifestparser 05:57:37 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:57:37 INFO - Running setup.py install for mozcrash 05:57:37 INFO - Running setup.py install for mozdebug 05:57:37 INFO - Running setup.py install for mozdevice 05:57:38 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:57:38 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:57:38 INFO - Running setup.py install for mozfile 05:57:38 INFO - Running setup.py install for mozhttpd 05:57:38 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:57:38 INFO - Running setup.py install for mozinfo 05:57:38 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:57:38 INFO - Running setup.py install for mozInstall 05:57:38 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:57:38 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:57:38 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:57:38 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:57:38 INFO - Running setup.py install for mozleak 05:57:38 INFO - Running setup.py install for mozlog 05:57:38 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:57:38 INFO - Running setup.py install for moznetwork 05:57:38 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:57:38 INFO - Running setup.py install for mozprocess 05:57:38 INFO - Running setup.py install for mozprofile 05:57:39 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:57:39 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:57:39 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:57:39 INFO - Running setup.py install for mozrunner 05:57:39 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:57:39 INFO - Running setup.py install for mozscreenshot 05:57:39 INFO - Running setup.py install for moztest 05:57:39 INFO - Running setup.py install for mozversion 05:57:39 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:57:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:57:39 INFO - Cleaning up... 05:57:39 INFO - Return code: 0 05:57:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f35ec832c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ae7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1888c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bf230>, '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 0x19116c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1911b70>, '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': '7f67ac1ceef7774224e327f2000001f6-1445602380.562456-627290231', '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 05:57:39 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 05:57:39 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 05:57:39 INFO - Using env: {'DISPLAY': ':0', 05:57:39 INFO - 'HOME': '/home/cltbld', 05:57:39 INFO - 'LANG': 'en_US.UTF-8', 05:57:39 INFO - 'LANGUAGE': 'en_US:en', 05:57:39 INFO - 'LOGNAME': 'cltbld', 05:57:39 INFO - 'MAIL': '/var/mail/cltbld', 05:57:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:39 INFO - 'MOZ_NO_REMOTE': '1', 05:57:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:39 INFO - 'NO_EM_RESTART': '1', 05:57:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:57:39 INFO - 'PWD': '/builds/slave/test-pgo', 05:57:39 INFO - 'SHELL': '/bin/bash', 05:57:39 INFO - 'SHLVL': '1', 05:57:39 INFO - 'TERM': 'linux', 05:57:39 INFO - 'TMOUT': '86400', 05:57:39 INFO - 'USER': 'cltbld', 05:57:39 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1445602380.562456-627290231', 05:57:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:39 INFO - '_': '/tools/buildbot/bin/python'} 05:57:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:57:39 INFO - Running setup.py (path:/tmp/pip-KW78h2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:57:39 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)) 05:57:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:57:39 INFO - Running setup.py (path:/tmp/pip-kom7wt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:57:39 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)) 05:57:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:57:39 INFO - Running setup.py (path:/tmp/pip-aVtN9U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:57:39 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)) 05:57:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:57:39 INFO - Running setup.py (path:/tmp/pip-TzdjbA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:57:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 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)) 05:57:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:57:39 INFO - Running setup.py (path:/tmp/pip-fgMl7y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:57:40 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)) 05:57:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:57:40 INFO - Running setup.py (path:/tmp/pip-zd6Q_2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:57:40 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)) 05:57:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:57:40 INFO - Running setup.py (path:/tmp/pip-WopFlD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 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)) 05:57:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:57:40 INFO - Running setup.py (path:/tmp/pip-LtmJks-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:57:40 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)) 05:57:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:57:40 INFO - Running setup.py (path:/tmp/pip-spp5V6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:57:40 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)) 05:57:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:57:40 INFO - Running setup.py (path:/tmp/pip-Bapljb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:57:40 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)) 05:57:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:57:40 INFO - Running setup.py (path:/tmp/pip-nQqxJz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:57:40 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)) 05:57:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:57:40 INFO - Running setup.py (path:/tmp/pip-Ad1pxV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:57:40 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)) 05:57:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:57:40 INFO - Running setup.py (path:/tmp/pip-FAN5jn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:57:40 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)) 05:57:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:57:40 INFO - Running setup.py (path:/tmp/pip-yupgV9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.10 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)) 05:57:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:57:40 INFO - Running setup.py (path:/tmp/pip-idnvUP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:57:40 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)) 05:57:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:57:40 INFO - Running setup.py (path:/tmp/pip-9kzi4G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:57:40 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)) 05:57:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:57:40 INFO - Running setup.py (path:/tmp/pip-Vr2heR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:57:40 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)) 05:57:40 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)) 05:57:40 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)) 05:57:40 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)) 05:57:40 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.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:57:40 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.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:57:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:44 INFO - Downloading blessings-1.5.1.tar.gz 05:57:44 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 05:57:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:57:44 INFO - Installing collected packages: blessings 05:57:44 INFO - Running setup.py install for blessings 05:57:44 INFO - Successfully installed blessings 05:57:44 INFO - Cleaning up... 05:57:45 INFO - Return code: 0 05:57:45 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:57:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:57:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:57:45 INFO - Reading from file tmpfile_stdout 05:57:45 INFO - Current package versions: 05:57:45 INFO - argparse == 1.2.1 05:57:45 INFO - blessings == 1.5.1 05:57:45 INFO - blobuploader == 1.2.4 05:57:45 INFO - docopt == 0.6.1 05:57:45 INFO - manifestparser == 1.1 05:57:45 INFO - mozInstall == 1.12 05:57:45 INFO - mozcrash == 0.16 05:57:45 INFO - mozdebug == 0.1 05:57:45 INFO - mozdevice == 0.46 05:57:45 INFO - mozfile == 1.2 05:57:45 INFO - mozhttpd == 0.7 05:57:45 INFO - mozinfo == 0.8 05:57:45 INFO - mozleak == 0.1 05:57:45 INFO - mozlog == 3.0 05:57:45 INFO - moznetwork == 0.27 05:57:45 INFO - mozprocess == 0.22 05:57:45 INFO - mozprofile == 0.27 05:57:45 INFO - mozrunner == 6.10 05:57:45 INFO - mozscreenshot == 0.1 05:57:45 INFO - mozsystemmonitor == 0.0 05:57:45 INFO - moztest == 0.7 05:57:45 INFO - mozversion == 1.4 05:57:45 INFO - psutil == 3.1.1 05:57:45 INFO - requests == 1.2.3 05:57:45 INFO - wsgiref == 0.1.2 05:57:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:45 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 0x7f35ec832c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ae7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1888c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bf230>, '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 0x19116c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1911b70>, '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': '7f67ac1ceef7774224e327f2000001f6-1445602380.562456-627290231', '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 05:57:45 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 05:57:45 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 05:57:45 INFO - Using env: {'DISPLAY': ':0', 05:57:45 INFO - 'HOME': '/home/cltbld', 05:57:45 INFO - 'LANG': 'en_US.UTF-8', 05:57:45 INFO - 'LANGUAGE': 'en_US:en', 05:57:45 INFO - 'LOGNAME': 'cltbld', 05:57:45 INFO - 'MAIL': '/var/mail/cltbld', 05:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:45 INFO - 'MOZ_NO_REMOTE': '1', 05:57:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:45 INFO - 'NO_EM_RESTART': '1', 05:57:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:57:45 INFO - 'PWD': '/builds/slave/test-pgo', 05:57:45 INFO - 'SHELL': '/bin/bash', 05:57:45 INFO - 'SHLVL': '1', 05:57:45 INFO - 'TERM': 'linux', 05:57:45 INFO - 'TMOUT': '86400', 05:57:45 INFO - 'USER': 'cltbld', 05:57:45 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1445602380.562456-627290231', 05:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:45 INFO - '_': '/tools/buildbot/bin/python'} 05:57:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:45 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)) 05:57:45 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)) 05:57:45 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)) 05:57:45 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)) 05:57:45 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)) 05:57:45 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)) 05:57:45 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)) 05:57:45 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)) 05:57:45 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)) 05:57:45 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)) 05:57:45 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)) 05:57:45 INFO - Cleaning up... 05:57:45 INFO - Return code: 0 05:57:45 INFO - Running post-action listener: _resource_record_post_action 05:57:45 INFO - Running post-action listener: _start_resource_monitoring 05:57:45 INFO - Starting resource monitoring. 05:57:45 INFO - ##### 05:57:45 INFO - ##### Running install step. 05:57:45 INFO - ##### 05:57:45 INFO - Running pre-action listener: _resource_record_pre_action 05:57:45 INFO - Running main action method: install 05:57:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:57:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:57:45 INFO - Reading from file tmpfile_stdout 05:57:45 INFO - Detecting whether we're running mozinstall >=1.0... 05:57:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:57:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:57:45 INFO - Reading from file tmpfile_stdout 05:57:45 INFO - Output received: 05:57:45 INFO - Usage: mozinstall [options] installer 05:57:45 INFO - Options: 05:57:45 INFO - -h, --help show this help message and exit 05:57:45 INFO - -d DEST, --destination=DEST 05:57:45 INFO - Directory to install application into. [default: 05:57:45 INFO - "/builds/slave/test-pgo"] 05:57:45 INFO - --app=APP Application being installed. [default: firefox] 05:57:45 INFO - mkdir: /builds/slave/test-pgo/build/application 05:57:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:57:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:58:00 INFO - Reading from file tmpfile_stdout 05:58:00 INFO - Output received: 05:58:00 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:58:00 INFO - Running post-action listener: _resource_record_post_action 05:58:00 INFO - ##### 05:58:00 INFO - ##### Running run-tests step. 05:58:00 INFO - ##### 05:58:00 INFO - Running pre-action listener: _resource_record_pre_action 05:58:00 INFO - Running main action method: run_tests 05:58:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:58:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:58:00 INFO - Python 2.7.3 05:58:00 INFO - Return code: 0 05:58:00 INFO - grabbing minidump binary from tooltool 05:58:00 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')]} 05:58:00 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 0x18bf230>, '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 0x19116c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1911b70>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:58:00 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 05:58:00 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 05:58:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:58:00 INFO - Return code: 0 05:58:00 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:58:00 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:58:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:58:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:58:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:58:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 05:58:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost 05:58:00 INFO - Using env: {'DISPLAY': ':0', 05:58:00 INFO - 'HOME': '/home/cltbld', 05:58:00 INFO - 'LANG': 'en_US.UTF-8', 05:58:00 INFO - 'LANGUAGE': 'en_US:en', 05:58:00 INFO - 'LOGNAME': 'cltbld', 05:58:00 INFO - 'MAIL': '/var/mail/cltbld', 05:58:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:58:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:00 INFO - 'MOZ_NO_REMOTE': '1', 05:58:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:58:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:00 INFO - 'NO_EM_RESTART': '1', 05:58:00 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:58:00 INFO - 'PWD': '/builds/slave/test-pgo', 05:58:00 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:58:00 INFO - 'SHELL': '/bin/bash', 05:58:00 INFO - 'SHLVL': '1', 05:58:00 INFO - 'TERM': 'linux', 05:58:00 INFO - 'TMOUT': '86400', 05:58:00 INFO - 'USER': 'cltbld', 05:58:00 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1445602380.562456-627290231', 05:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:00 INFO - '_': '/tools/buildbot/bin/python'} 05:58:00 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost'] with output_timeout 3600 05:58:00 INFO - mozversion INFO | application_buildid: 20151023030245 05:58:00 INFO - mozversion INFO | application_changeset: 0625c68c0abcfe4d10880d15d8fe7d06df3369c9 05:58:00 INFO - mozversion INFO | application_display_name: Nightly 05:58:00 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:58:00 INFO - mozversion INFO | application_name: Firefox 05:58:00 INFO - mozversion INFO | application_remotingname: firefox 05:58:00 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:58:00 INFO - mozversion INFO | application_vendor: Mozilla 05:58:00 INFO - mozversion INFO | application_version: 44.0a1 05:58:00 INFO - mozversion INFO | platform_buildid: 20151023030245 05:58:00 INFO - mozversion INFO | platform_changeset: 0625c68c0abcfe4d10880d15d8fe7d06df3369c9 05:58:00 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:58:00 INFO - mozversion INFO | platform_version: 44.0a1 05:58:00 INFO - 2015-10-23 05:58:00,500 DEBUG : using testdate: 1445605080 05:58:00 INFO - 2015-10-23 05:58:00,500 DEBUG : actual date: 1445605080 05:58:00 INFO - 2015-10-23 05:58:00,614 INFO : starting webserver on 'localhost:45448' 05:58:00 INFO - 2015-10-23 05:58:00,615 INFO : Starting test suite talos-linux64-ix-041 05:58:00 INFO - 2015-10-23 05:58:00,615 INFO : Starting test dromaeo_css 05:58:00 INFO - 2015-10-23 05:58:00,615 DEBUG : operating with platform_type : linux_ 05:58:00 INFO - 2015-10-23 05:58:00,615 INFO : Initialising browser for dromaeo_css test... 05:58:00 INFO - 2015-10-23 05:58:00,642 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHkKjjw/profile http://localhost:45448/getInfo.html 05:58:06 INFO - 2015-10-23 05:58:06,068 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:58:06 INFO - 2015-10-23 05:58:06,068 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:58:06 INFO - 2015-10-23 05:58:06,068 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:58:06 INFO - 2015-10-23 05:58:06,068 DEBUG : BROWSER_OUTPUT: __metrics 05:58:06 INFO - 2015-10-23 05:58:06,257 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:58:07 INFO - 2015-10-23 05:58:07,679 INFO : Browser initialized. 05:58:07 INFO - 2015-10-23 05:58:07,679 INFO : Running cycle 1/1 for dromaeo_css test... 05:58:07 INFO - 2015-10-23 05:58:07,679 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHkKjjw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:58:19 INFO - 2015-10-23 05:58:19,373 DEBUG : BROWSER_OUTPUT: RSS: Main: 141615104 05:58:19 INFO - 2015-10-23 05:58:19,373 DEBUG : BROWSER_OUTPUT: 05:59:10 INFO - 2015-10-23 05:59:10,451 DEBUG : BROWSER_OUTPUT: 1445605150448 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] 06:01:19 INFO - 2015-10-23 06:01:19,830 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45448/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45448/tests/dromaeo/cssquery-ext.html) 06:01:21 INFO - 2015-10-23 06:01:21,047 DEBUG : BROWSER_OUTPUT: RSS: Main: 273620992 06:01:21 INFO - 2015-10-23 06:01:21,047 DEBUG : BROWSER_OUTPUT: 06:04:23 INFO - 2015-10-23 06:04:23,387 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45448/tests/dromaeo/cssquery-ext.html (next: http://localhost:45448/tests/dromaeo/cssquery-jquery.html) 06:04:23 INFO - 2015-10-23 06:04:23,962 DEBUG : BROWSER_OUTPUT: RSS: Main: 221732864 06:04:23 INFO - 2015-10-23 06:04:23,962 DEBUG : BROWSER_OUTPUT: 06:07:25 INFO - 2015-10-23 06:07:25,818 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45448/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45448/tests/dromaeo/cssquery-mootools.html) 06:07:26 INFO - 2015-10-23 06:07:26,387 DEBUG : BROWSER_OUTPUT: RSS: Main: 219754496 06:07:26 INFO - 2015-10-23 06:07:26,387 DEBUG : BROWSER_OUTPUT: 06:10:28 INFO - 2015-10-23 06:10:28,129 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45448/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45448/tests/dromaeo/cssquery-prototype.html) 06:10:28 INFO - 2015-10-23 06:10:28,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 207036416 06:10:28 INFO - 2015-10-23 06:10:28,695 DEBUG : BROWSER_OUTPUT: 06:13:31 INFO - 2015-10-23 06:13:31,256 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45448/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45448/tests/dromaeo/cssquery-yui.html) 06:13:31 INFO - 2015-10-23 06:13:31,844 DEBUG : BROWSER_OUTPUT: RSS: Main: 206843904 06:13:31 INFO - 2015-10-23 06:13:31,844 DEBUG : BROWSER_OUTPUT: 06:16:34 INFO - 2015-10-23 06:16:34,375 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45448/tests/dromaeo/cssquery-yui.html (next: http://localhost:45448/tests/dromaeo/cssquery-dojo.html) 06:16:34 INFO - 2015-10-23 06:16:34,619 DEBUG : BROWSER_OUTPUT: RSS: Main: 234323968 06:16:34 INFO - 2015-10-23 06:16:34,619 DEBUG : BROWSER_OUTPUT: 06:16:34 INFO - 2015-10-23 06:16:34,620 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:16:34 INFO - 2015-10-23 06:16:34,620 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:16:34 INFO - 2015-10-23 06:16:34,621 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:16:34 INFO - 2015-10-23 06:16:34,621 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:16:34 INFO - 2015-10-23 06:16:34,622 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3262.3149138680874;3336.8164750938718;3358.6641335866416;3361.210115622829;3363.529105925171;5487.341519017724;5585.190147428621;5740.483356497914;5752.568557358194;5768.913466298004;5674.233978412913;5686.289213848258;5692.203091567184;5693.402192769761;5764.337101233359;5187.792488300483;5193.091209038422;5220.060389129955;5230.607704422165;5236.7905283788605;5147.974260128694;5163.81926632568;5217.452167522412;5270.736463176826;5281.339832520935;5000.249962505617;5083.186690129562;5085.440601533828;5219.582433405338;5220.29526013987;5167.638265321429;5178.4562620924635;5194.584433245332;5210.166373380241;5213.973930130363;5177.974110129463;5197.350331208599;5207.661502002357;5224.52979231871;5230.084735171368;5347.7058761768085;5392.757325920304;5452.482014208644;5499.285092937893;5535.667859928377;6009.939900600982;6064.423879731463;6070.6357618543025;6083.878322433527;6093.482054025413;6095.603785753956;6096.211917361819;6099.359567245419;6106.603070800384;6107.358727333655;5444.3194600674915;5536.003519366513;5560.138178582326;5625.184348269478;5678.432156784371;6143.508519318533;6156.969215153896;6171.043488259327;6171.475424588871;6198.535109866778;5732.713364331767;5953.732082056231;5964.970175149097;5966.970165149147;5969;5902.026165682614;5956.16613674086;5986.820395388146;5989.1914591529585;6035.939640603538;6044.546659000593;6049.062395328731;6052.969735151296;6058.848528786727;6073.301570319381;5818.21454103699;5951.464368206882;6038.728257228435;6065.605735627259;6065.8180254592435;4486.080353527519;4567.086582683477;4578.061497393026;4596;4616.28447590624;4133.04939863833;4142.875713728593;4144.958550414518;4200.159968006411;4214.7471151731;5433.26650902131;5663.801766938137;5697.373288938214;5697.6296540724725;5704.8859022819315;5881.411858814085;5919.526437884959;6019.668918209541;6098.058532604889;6105.065535583899;5710.029295019856;5710.771569137188;5719.370869204384;5732.799352022659;5761.654300741969;4942.802287908444;5216.530512253916;5221.869453263699;5225.843224703265;5227.712475813791;6140.293866205354;6166.845828854314;6302.779402720883;6305.2433707953505;6316.210473690789;6067.271927368744;6069.36271691466;6081.118237855575;6089.5737298388685;6097;5996.610220335664;6098.451139397475;6247.718852651551;6261.405166509175;6273.498120150286;5863.589548731547;5869.413058694096;5884.382139875423;5906.616069955439;5954.940450595612;5903.173555702119;5919.556033297434;5922.318933322723;5938.792142275;6022.247219097613;5616.466435688603;5720.513756330592;5838.795642152504;5848.64908105515;5859.20900678403;5715.542756579381;5750.654960702372;5767.452092051249;5808.535317174531;5843.211166492469;5777.104548794943;5783.508401785727;5787.681677507778;5792.536597072309;5800.9419905800405;5689.061304884648;5847.210626565359;5894.498967587803;5913.142594323885;5913.852153696192;5602.215689803349;5778.36437991829;5782.1615865698395;5787.334456537384;5826.300843898759 06:16:34 INFO - 2015-10-23 06:16:34,626 DEBUG : BROWSER_OUTPUT: |1;ext.html;558.4276116980097;599.6791716431709;606.9484093852021;620.5532016947795;624.9750009999594;31378;39754.80122599386;40462.393064104064;40501;40504.79747601265;43114.78442607783;43580.346294805604;43586.346204806956;43612;43642;7867.016622922135;7990.041195056601;8998.999999999984;9176.26589872812;10552.630657926975;10731.678049658523;10762.085222756075;10858.294210876307;10892.673219803419;10903.727406814853;10721.678349649485;10837.512311945942;10852.07757340627;10922.726931826688;10966.670999869977;8007.599620019005;8162.469439486444;10993.395363255018;11271.830922536168;11277.774444511064;10631.362118272928;10788.460576971198;10799.568017279378;10805.567777288978;10808.459577021196;40848.795756021325;41403.7929810352;41419.37870931938;41497.585024149674;41577.792111039555;3239.578854748891;3240.578724765789;3322.750793690483;3566.7146628269934;4102.3026085565225;29712.257193570116;29989.550156747668;30553;30653.540196897065;30662;3006.383691343291;3070.140360699008;3090.9690903090905;3106.7048630380077;3122.73456756176;295343;296541;296990.5150474255;297673;298868;55793.442065579635;56743.432565673815;56848.431515685144;57216.713916430985;61897.21462534197;60019.699901500215;60259;60346.698266508385;60516.092258616154;60543.69728151331;15474.303656335493;15503.302351394213;15592.298346574431;15592.766108508382;15637.452689155825;12060.819087713691;12120.212186207867;12124.333161676017;12133.757324853454;12135.63593092191;18695.15871785773;18893.7165942511;18983.430497085108;19010.61978760417;19073.904630477038;8302.584870756438;8577.228049475578;8578.270846978077;8588.957055214683;8612.267957223581;873.8470767615642;894.2130924786277;913.6254135804288;1004.2167109654481;1048.8636477257908;28846.278843029093;28936.855315723285;29284.26789330241;29361.11916642504;33677.66322336794;1013.3919648211014;1026.9319907296328;1063.5054699564585;1172.9736480579493;1215.1493954231896;15643.608909777347;15784.526464205863;15875.444359447363;15925.442609508611;16181.757273640906;383629;389274;390133;390542;391359;55062.724686376314;55376;55438.44561554414;55447.722761385936;55504.44495554993;1316.493150137204;1317.3939987605618;1341.4231880291372;1355.3358854161588;1387.2855479428104;28551.571726424536;29226.269343266587;29263.268418289714;29619.40761184721;29705.5544166842;47173.52826471828;47581.762091189325;47595;47605;47666.76166619283;307476;307574;307994;308578;309067;28429.857850710614;28846.7115328844;32675.34649307048;33258.50112248366;34200.82899585586;39443.605563945144;39548.40677389899;39734.60265397309;39890;40650.79674601608;34445.65554344424;34470;35008.649913501555;41945.37081943712;43234.783826081926;32237.142233770468;38042;39099.218015640094;41206.381904270864;42016.67264967507;36517.26965460729;36813.26373472569;37564.81217593895;37735.81132094322;37797.62202377941;32056.679433206304;33152.50271245885;35330.47004294989;35331.41781432717;35767.28465430625;26367.34081647974;26382.07662731795;26432.339191520365;26485;26730.866345668146 06:16:34 INFO - 2015-10-23 06:16:34,626 DEBUG : BROWSER_OUTPUT: |2;jquery.html;397.97413168144067;398.9780562069085;401.5161730115211;404.8481819317755;405.3736976371506;11061.668149955494;11421.657350279484;17091;17515.64968700625;17532.21105050274;12186.81719774204;12199;12238.75522489552;12352.505899763999;12701.682457938534;4594.10414969082;4683.180443422404;4694.765261736917;4696.459907110692;4698.154332220199;3679.208970071434;3769.7172712046568;4590.5409459054;5059.797608095671;5177.45636708144;5130.127878260705;5134.7432628368615;5135.127028405162;5138.203578445347;5151.45909679482;4989.251612258154;5093.847184584469;5159.071367153911;5159.277701121846;5164.483551644843;4492.663050271242;4513.300438432048;4523.773811309455;4532.501424843264;4536.682432229745;14107.647308817259;14350.784738228935;14360.210188439632;14368.353424095942;14784.852151478455;2005.6991451282424;2047.0890453748088;2136.8504204705678;2174.717286752728;2260.400993736661;10172.542235599416;10269.435181065039;10318.380897146195;10544.10375118116;10601.946990265076;1764.8941063536101;1765.7439671247726;1770.7697999260142;1877.8873267603988;1893.072394526672;63601.36398636047;63613.68193159051;64528;66439.33560664428;67344.66327668379;7325.926740732631;7336.082989626297;7352;7352.772614236105;7404.666789994463;8792.42849214799;8843.734687959372;8859.734207973772;8863.290936725047;8913.420627659181;5651.57613179005;5745.798897038583;5775.8556036099435;5819.679917604572;5820.214271073435;5928;5974.3428222895445;5982.9401705983255;6022.217111775529;6026.578139530191;3483.6690514401093;3490.528778614905;3495.8252087395526;3516.9648303516637;3519.3841077811794;1223.6757259326287;1244.3156264054733;1274.9171303865219;1301.9349032548334;1314.9808898104045;467.483430808958;468.19937906180814;485.6479052686774;489.4664815351213;496.7863818558055;12013;12069.758604827854;12082.697932551757;12093.818592721116;13035.348232588522;468.981240750373;486.9561739443467;502.28675281100925;502.64563482744575;514.3801718928682;6712.194536655535;6835.07726456922;6924.376806087476;6959.965200174068;7010.158780946319;570427;570453;573467;574104;582003;78347;81330.18669813345;81421;82558.58720706477;82873.58563207145;535.5501378841792;543.6248988198209;545.280230096277;547.0426753181931;547.0918275662382;11627.825582616098;11674.533018679158;11973.76052478963;12007.039436844856;12021.038316934799;34755.30489390249;34980.67683570057;35034.24828758501;35226.47160292546;36416.45375319319;46396;50236.246456302455;50877.49122508727;52770;52847.47152528426;6791.04925310447;6799.932000680128;6803;6859.108315918898;6865.107536020485;12945.640707725554;13166.144200626928;13435.261060641758;13449.731005380034;13455.798163027759;10978.505967231335;11228.4385780709;11394.829077563678;11422.885771142182;11491.367974761468;10616.946915265375;10927.39899305514;11089.50097245642;11151.832722509007;11331.603393881174;11147;11225.494852731483;11306.265092768943;11359.602413915472;11410.714732131763;6953.304669533209;7282.453815963718;7381.889271661037;7384.224656410999;7396.14944281393;10569.63006294776;10876.836847447454;11133.332000080021;11337.093032557541;11431.085513159094 06:16:34 INFO - 2015-10-23 06:16:34,629 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1427.6002719238618;1575.7951466309378;1727.9632220667602;1867.673157197491;1976.5453945592512;8137.674493020279;9174.17432431082;9279.907200927988;9282.211012063974;9283.814323713521;9247.121523455278;9319.627214911396;9367.484788336638;9385.577649005794;9634.566444509996;2193.3748881568754;2231.6764069209953;2490.651308816767;2494.1519883239694;2516.7609077137645;2528.886200120999;2564.756348146923;2573.819832611718;2576.716561178269;2577.8066645001604;2489.4523204894895;2509.7866681332107;2510.297116807297;2511.259178542325;2512.572862613351;2135.679648052789;2178.56428714257;2479.8636075015866;2579.638850560923;2581.4062765564026;2539.5428822811887;2539.5682733935278;2571.6014017827265;2585.4312051348675;2587.5471792436438;9356.298277629137;9398.67104651334;9401.905980940172;9411.62353505859;9413;5580.135079062711;5682.602217844753;5686.2039314496005;5687.289088863892;5687.317521897398;3531;3554.2713743682484;3570.9642903570893;3646.3436581415335;3647.1793846384617;1177.570186881782;1182.532899504691;1187.7683851648933;1196.7068068323229;1255.522901297501;14103;14231;14233.572992810128;14239.78640320396;14242.287885605781;5006.199008158677;5089.592832573385;5131.512506311894;5155.819546315861;5168.793248270027;11935.820962685566;11977.760444791229;11992.880071199352;11997.400129993466;11997.880021199851;5584.274044374205;5586.659201791622;5587.636803607753;5588.636738611977;5590.189422533791;4868.61051115917;4943.876403089952;4955.083309587738;4959;4960.305557221992;4228.921624985609;4232.873013809591;4244.236037513216;4251.9787401062795;4258.914821703611;1337.277869950216;1348.5280151946936;1349.6625843539116;1357.1043111546333;1359.8572149924314;1343.9126456780473;1345.4349173347218;1347.6563476313477;1376.1949259682997;1405.1779708870222;8900.376973611914;9118.40730352525;9121.863172052424;9123.498207598646;9127.68053118151;553.8476918847268;565.8132816170736;573.6386076771607;573.7274794472592;575.2952633024595;6771.085903402977;6829.282925292872;6852.897206541906;6874.9656251718425;6885.345892140239;12030.15788894769;12198.024158067334;12208.389580520938;12219.450124744408;12221.877781222074;11757.647270581896;11854.703632409259;12033.278003319829;12041.879581204252;12129.272243665408;8701.738947831574;8782.736517904345;8790.208881200722;8796.208341249318;8800.119988001277;8356.289715374018;8529.3602979778;8553.82892342162;8556.700515482178;8566.82866342682;10145.797084058426;10252.64115755945;10313.22650801178;10509.632162874263;10515.211359147941;10590.417527036087;10738.516766745359;10745.623903163352;10768.730781730206;10769.084627806724;8589.44168629037;8707.782305442415;8716.259117974789;8734.868976965477;8737.475751454933;9415.435073895589;9481.241500680067;9489.051094890456;9491.905080949102;9534;7595.5442673439775;8508.234258916727;8792.560371981248;8879.866801997847;9092.272618190662;8335.95832020836;8589.226969572768;8601.22588966996;8662.047174810892;8741;8534.78663033429;8564;8627.309815214894;8647.827043459221;8648.913510865063;7896.210378962058;7902.407319451179;7928.365730741642;7958.0848202457455;7961.40289478303;7952.204779522233;7966.243206895336;8067.233612807008;8070.919290807017;8072.959635202022 06:16:34 INFO - 2015-10-23 06:16:34,629 DEBUG : BROWSER_OUTPUT: |4;prototype.html;373.07291380918423;380.7962739934134;381.3734422687241;383.55699167461574;386.1716617854702;5729.455701708342;5801.680907550078;5803.651780893149;5815.534757219423;5845.620034697747;5681.744321505532;5750.137479378085;5766.365699773032;5787.045137552299;5792.131180322943;4564.657650676196;4588.587027167554;4596.632269418438;4597.7011494252765;4599.44806623204;4449.17690227309;4517.7289362638185;4535.365048893158;4595.402597662299;4607.493175750665;4556.9088618227615;4557.08858228354;4563.703359281636;4570.817167313304;4576.931346029813;4538.047010127877;4550.977245113786;4557.065801510682;4558.566936141061;4561.635069194456;4097.057676734368;4098.426220329156;4099.467069281004;4101.692373072032;4102.159057393227;5465.07093794056;5516.393196748395;5528.5024347808485;5559.360673522516;5564.916526252109;5131.025105229995;5132.204508301219;5135.563477104451;5138.126518491866;5142.125838607409;5747.252857128588;5962.493188079018;5968.940310596882;5969.925413425582;5970.611910225864;4259.5101563319995;4281.636060934824;4332.978335108304;4335.1329734053315;4337.1976184405985;6087.269527656666;6140.877182456371;6142.508599312045;6147.907781383283;6173.351798061184;4456.732596044248;4457.375967364572;4460.442444694413;4464.642828573771;4475.686701930898;4481.731096134243;4522.4346956630425;4527.660425468103;4528.728276303433;4593.874500747338;5177.197534382177;5178.508041736029;5181.948180518222;5183.0670479314085;5184.922226166611;6074.42292982166;6079.635221886701;6081.452669259788;6084.817455476343;6085.878282434326;1633.3793158599656;1650.3233674193764;1652.4381710218343;1653.3138747419687;1653.7602047703015;1117.9608713694981;1128.480898786551;1156.6761306833932;1157.2824848593925;1158.1719070864203;5796.275465566804;5802.332731735904;5830;5832.533397328203;5839.795607153814;6160.630362178284;6198.504119670506;6199.380061993765;6202.131701561785;6226.62640241587;5786.421357864264;5817.7382017809305;5826.329972053183;5831.446012628793;5834.883302333929;3305.3554556861664;3385.2044769479153;3415.624281329052;3416.4362880125;3416.5558477398276;6399.296077431479;6414.166158399378;6422.550421470452;6425.74297028123;6426.967865160645;6282.623042617458;6289.55973081889;6292.119103325538;6293.465055470337;6296.307406185316;6259.906101408483;6419.903701444482;6420.261669907927;6429.5499315049365;6436.227652681709;5999.3100793407575;6083.908741368795;6206.627602343874;6214.5960512566535;6218.81343559694;6061;6099.11562823397;6113.663748493876;6123.785667501616;6140.600860944024;6377.87244255103;6380.202474690664;6380.776672816429;6383.234011918599;6383.457406120532;4439.844605438794;4518.43519560055;4519.480259770037;4528.728276303433;4530.818767249405;6140.17107690456;6199.287081985449;6232.065190221322;6240.251169859646;6242.344553821783;6075.939240607714;6076.149339092619;6077.878442431215;6079.300880398634;6080.422359875804;6043.728032238472;6055.6063855849225;6060.060690592965;6061.1514387984835;6062.120992456157;5818.0981947798155;5925.1704761332585;5933.554983376178;5934.347221805684;5941.1385349125;6008.87982240344;6052.303985041601;6054.848628784315;6055.545834062551;6067.271927368744;5925.081612350093;5929.881402372014;5930.584859059824;5937.673427961504;5939.10913362999 06:16:34 INFO - 2015-10-23 06:16:34,631 DEBUG : BROWSER_OUTPUT: |5;yui.html;753.3972821742605;774.1368374262698;807.7334479621726;813.825027619062;841.9873701894472;13034.543790967318;13349.799753003712;13353.53262635808;13353.866461335383;13353.866461335396;12214.51141954323;12305.200161989464;12305.815412768816;12312.753744925118;12317.322547259897;677.8136012596526;678.3250665587747;819.1153554161491;827.9710210142646;828.1801016993163;829.995850020749;831.6964308027557;836.8744688296774;837.4556538250125;838.2707044870971;704.4962851561132;864.3344624639025;868.179570306061;868.552695361886;869;704.1620471638734;845.222395396237;861.5175501719058;861.8147098373817;862.2412277196028;644.230144976753;644.2462319086679;644.4361183964031;645.2160624840794;645.5287640022763;12473.688157796038;12583.496660133584;12595.874041259653;12606.495740170381;12675.30285834288;11064.225504214708;11139.777204455866;11365.715857103556;11523.19337646365;11626.476808543552;9586.185174260196;9702.223822094216;9741;9798.461084640341;9932;3381.289929114864;3523.7533372663925;3572;3598.1904071583945;3603.6756691897594;39502.802485987675;39506.40740388897;39652;39668.801655991534;39714.20571588552;9401.10689484498;9573.377730447499;9577.23382129428;9723.562439690231;9729.318947673595;17600.119994000248;17665.558361041076;17678.46964591064;17679.73480397795;17682.292708291523;7410.296021877913;7568.394528437711;7584.5070070445245;7637.752318603316;7699.076110866732;4200.4959404871615;4241.745495270294;4261.275583150872;4334.50153232376;4381.38660587518;3000.8799648013833;3032.5754394384803;3033.1052339559883;3036.3927214557175;3134.200778801391;484.16239904964607;491.5134017322825;497.1027295731168;502.4322515557397;502.7762645622736;532.6590981771669;578.5949835115351;627.4823270801606;658.9967050164719;682.668905580793;8574.35346969607;8617.784555386166;8749.25631321332;8756.774051632776;9074.86387704185;555.7246120154256;665.55075324156;680.2415306932735;693.968771405288;694.583250049966;3951.7036222283446;4068.8575899843954;4134.979325103355;4182.205380977665;4275.657947364203;49686;50605.24092138621;50691.493085069415;50742.74628626907;50748;42984;43319;43362.783186084496;43377.13245735068;43870.34194487085;37656;38067.99999999945;38187;38282;38377.80811095927;8228.382871284557;8277.793055173668;8305.916940830515;8324.978426883355;8395.874061889199;25970.87014564915;26348.20955371342;26568.8671556641;26765.598516022666;26828.195154145407;35762.64237357593;36575.817120914224;37047.62952370442;37699.81150094232;37705.245895082495;7967.920320796949;8086.7169649062;8105.797355066171;8131.837363252584;8265.752027439186;11682.182247242612;11821.70445738829;11833.230839995373;11837.171398002058;12452.190607610477;11400.144989126014;11416.200865939636;11563.595274165364;11683.18217724751;11869.881301186877;11161.051310638362;11375.31748095117;11490.77018459643;11682.182247242612;11813.763724725286;10551.314164579278;10995.725106872073;11235.887641123483;11262.267952583055;11644.301341919512;9347.485888275938;9434.10301423801;9444.716658500256;9627.518624068629;9756.756081097745;8702.825943480968;9162.954185229031;9264.166225039779;9499.715008549754;9749.512524373895 06:16:34 INFO - 2015-10-23 06:16:34,631 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:16:34 INFO - 2015-10-23 06:16:34,631 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:16:34 INFO - 2015-10-23 06:16:34,631 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1008 06:16:34 INFO - 2015-10-23 06:16:34,631 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:16:34 INFO - 2015-10-23 06:16:34,631 DEBUG : BROWSER_OUTPUT: __startTimestamp1445606194619__endTimestamp 06:16:34 INFO - 2015-10-23 06:16:34,631 DEBUG : BROWSER_OUTPUT: 06:16:34 INFO - 2015-10-23 06:16:34,631 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:16:34 INFO - 2015-10-23 06:16:34,631 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:16:34 INFO - 2015-10-23 06:16:34,631 DEBUG : BROWSER_OUTPUT: 06:16:34 INFO - 2015-10-23 06:16:34,631 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5591.02 Median:5768.91 stddev:614.55 (10.7%) stddev-sans-first:588.66 06:16:34 INFO - 2015-10-23 06:16:34,631 DEBUG : BROWSER_OUTPUT: Values: 3262.3 3336.8 3358.7 3361.2 3363.5 5487.3 5585.2 5740.5 5752.6 5768.9 5674.2 5686.3 5692.2 5693.4 5764.3 5187.8 5193.1 5220.1 5230.6 5236.8 5148.0 5163.8 5217.5 5270.7 5281.3 5000.2 5083.2 5085.4 5219.6 5220.3 5167.6 5178.5 5194.6 5210.2 5214.0 5178.0 5197.4 5207.7 5224.5 5230.1 5347.7 5392.8 5452.5 5499.3 5535.7 6009.9 6064.4 6070.6 6083.9 6093.5 6095.6 6096.2 6099.4 6106.6 6107.4 5444.3 5536.0 5560.1 5625.2 5678.4 6143.5 6157.0 6171.0 6171.5 6198.5 5732.7 5953.7 5965.0 5967.0 5969.0 5902.0 5956.2 5986.8 5989.2 6035.9 6044.5 6049.1 6053.0 6058.8 6073.3 5818.2 5951.5 6038.7 6065.6 6065.8 4486.1 4567.1 4578.1 4596.0 4616.3 4133.0 4142.9 4145.0 4200.2 4214.7 5433.3 5663.8 5697.4 5697.6 5704.9 5881.4 5919.5 6019.7 6098.1 6105.1 5710.0 5710.8 5719.4 5732.8 5761.7 4942.8 5216.5 5221.9 5225.8 5227.7 6140.3 6166.8 6302.8 6305.2 6316.2 6067.3 6069.4 6081.1 6089.6 6097.0 5996.6 6098.5 6247.7 6261.4 6273.5 5863.6 5869.4 5884.4 5906.6 5954.9 5903.2 5919.6 5922.3 5938.8 6022.2 5616.5 5720.5 5838.8 5848.6 5859.2 5715.5 5750.7 5767.5 5808.5 5843.2 5777.1 5783.5 5787.7 5792.5 5800.9 5689.1 5847.2 5894.5 5913.1 5913.9 5602.2 5778.4 5782.2 5787.3 5826.3 06:16:34 INFO - 2015-10-23 06:16:34,632 DEBUG : BROWSER_OUTPUT: 06:16:34 INFO - 2015-10-23 06:16:34,632 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:50188.66 Median:3240.08 stddev:87541.90 (2701.8%) stddev-sans-first:87708.17 06:16:34 INFO - 2015-10-23 06:16:34,633 DEBUG : BROWSER_OUTPUT: Values: 558.4 599.7 606.9 620.6 625.0 31378.0 39754.8 40462.4 40501.0 40504.8 43114.8 43580.3 43586.3 43612.0 43642.0 7867.0 7990.0 8999.0 9176.3 10552.6 10731.7 10762.1 10858.3 10892.7 10903.7 10721.7 10837.5 10852.1 10922.7 10966.7 8007.6 8162.5 10993.4 11271.8 11277.8 10631.4 10788.5 10799.6 10805.6 10808.5 40848.8 41403.8 41419.4 41497.6 41577.8 3239.6 3240.6 3322.8 3566.7 4102.3 29712.3 29989.6 30553.0 30653.5 30662.0 3006.4 3070.1 3091.0 3106.7 3122.7 295343.0 296541.0 296990.5 297673.0 298868.0 55793.4 56743.4 56848.4 57216.7 61897.2 60019.7 60259.0 60346.7 60516.1 60543.7 15474.3 15503.3 15592.3 15592.8 15637.5 12060.8 12120.2 12124.3 12133.8 12135.6 18695.2 18893.7 18983.4 19010.6 19073.9 8302.6 8577.2 8578.3 8589.0 8612.3 873.8 894.2 913.6 1004.2 1048.9 28846.3 28936.9 29284.3 29361.1 33677.7 1013.4 1026.9 1063.5 1173.0 1215.1 15643.6 15784.5 15875.4 15925.4 16181.8 383629.0 389274.0 390133.0 390542.0 391359.0 55062.7 55376.0 55438.4 55447.7 55504.4 1316.5 1317.4 1341.4 1355.3 1387.3 28551.6 29226.3 29263.3 29619.4 29705.6 47173.5 47581.8 47595.0 47605.0 47666.8 307476.0 307574.0 307994.0 308578.0 309067.0 28429.9 28846.7 32675.3 33258.5 34200.8 39443.6 39548.4 39734.6 39890.0 40650.8 34445.7 34470.0 35008.6 41945.4 43234.8 32237.1 38042.0 39099.2 41206.4 42016.7 36517.3 36813.3 37564.8 37735.8 37797.6 32056.7 33152.5 35330.5 35331.4 35767.3 26367.3 26382.1 26432.3 26485.0 26730.9 06:16:34 INFO - 2015-10-23 06:16:34,633 DEBUG : BROWSER_OUTPUT: 06:16:34 INFO - 2015-10-23 06:16:34,633 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28445.19 Median:4534.59 stddev:94142.73 (2076.1%) stddev-sans-first:94383.26 06:16:34 INFO - 2015-10-23 06:16:34,634 DEBUG : BROWSER_OUTPUT: Values: 398.0 399.0 401.5 404.8 405.4 11061.7 11421.7 17091.0 17515.6 17532.2 12186.8 12199.0 12238.8 12352.5 12701.7 4594.1 4683.2 4694.8 4696.5 4698.2 3679.2 3769.7 4590.5 5059.8 5177.5 5130.1 5134.7 5135.1 5138.2 5151.5 4989.3 5093.8 5159.1 5159.3 5164.5 4492.7 4513.3 4523.8 4532.5 4536.7 14107.6 14350.8 14360.2 14368.4 14784.9 2005.7 2047.1 2136.9 2174.7 2260.4 10172.5 10269.4 10318.4 10544.1 10601.9 1764.9 1765.7 1770.8 1877.9 1893.1 63601.4 63613.7 64528.0 66439.3 67344.7 7325.9 7336.1 7352.0 7352.8 7404.7 8792.4 8843.7 8859.7 8863.3 8913.4 5651.6 5745.8 5775.9 5819.7 5820.2 5928.0 5974.3 5982.9 6022.2 6026.6 3483.7 3490.5 3495.8 3517.0 3519.4 1223.7 1244.3 1274.9 1301.9 1315.0 467.5 468.2 485.6 489.5 496.8 12013.0 12069.8 12082.7 12093.8 13035.3 469.0 487.0 502.3 502.6 514.4 6712.2 6835.1 6924.4 6960.0 7010.2 570427.0 570453.0 573467.0 574104.0 582003.0 78347.0 81330.2 81421.0 82558.6 82873.6 535.6 543.6 545.3 547.0 547.1 11627.8 11674.5 11973.8 12007.0 12021.0 34755.3 34980.7 35034.2 35226.5 36416.5 46396.0 50236.2 50877.5 52770.0 52847.5 6791.0 6799.9 6803.0 6859.1 6865.1 12945.6 13166.1 13435.3 13449.7 13455.8 10978.5 11228.4 11394.8 11422.9 11491.4 10616.9 10927.4 11089.5 11151.8 11331.6 11147.0 11225.5 11306.3 11359.6 11410.7 6953.3 7282.5 7381.9 7384.2 7396.1 10569.6 10876.8 11133.3 11337.1 11431.1 06:16:34 INFO - 2015-10-23 06:16:34,634 DEBUG : BROWSER_OUTPUT: 06:16:34 INFO - 2015-10-23 06:16:34,634 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:6668.55 Median:5047.90 stddev:3712.54 (73.5%) stddev-sans-first:3702.06 06:16:34 INFO - 2015-10-23 06:16:34,635 DEBUG : BROWSER_OUTPUT: Values: 1427.6 1575.8 1728.0 1867.7 1976.5 8137.7 9174.2 9279.9 9282.2 9283.8 9247.1 9319.6 9367.5 9385.6 9634.6 2193.4 2231.7 2490.7 2494.2 2516.8 2528.9 2564.8 2573.8 2576.7 2577.8 2489.5 2509.8 2510.3 2511.3 2512.6 2135.7 2178.6 2479.9 2579.6 2581.4 2539.5 2539.6 2571.6 2585.4 2587.5 9356.3 9398.7 9401.9 9411.6 9413.0 5580.1 5682.6 5686.2 5687.3 5687.3 3531.0 3554.3 3571.0 3646.3 3647.2 1177.6 1182.5 1187.8 1196.7 1255.5 14103.0 14231.0 14233.6 14239.8 14242.3 5006.2 5089.6 5131.5 5155.8 5168.8 11935.8 11977.8 11992.9 11997.4 11997.9 5584.3 5586.7 5587.6 5588.6 5590.2 4868.6 4943.9 4955.1 4959.0 4960.3 4228.9 4232.9 4244.2 4252.0 4258.9 1337.3 1348.5 1349.7 1357.1 1359.9 1343.9 1345.4 1347.7 1376.2 1405.2 8900.4 9118.4 9121.9 9123.5 9127.7 553.8 565.8 573.6 573.7 575.3 6771.1 6829.3 6852.9 6875.0 6885.3 12030.2 12198.0 12208.4 12219.5 12221.9 11757.6 11854.7 12033.3 12041.9 12129.3 8701.7 8782.7 8790.2 8796.2 8800.1 8356.3 8529.4 8553.8 8556.7 8566.8 10145.8 10252.6 10313.2 10509.6 10515.2 10590.4 10738.5 10745.6 10768.7 10769.1 8589.4 8707.8 8716.3 8734.9 8737.5 9415.4 9481.2 9489.1 9491.9 9534.0 7595.5 8508.2 8792.6 8879.9 9092.3 8336.0 8589.2 8601.2 8662.0 8741.0 8534.8 8564.0 8627.3 8647.8 8648.9 7896.2 7902.4 7928.4 7958.1 7961.4 7952.2 7966.2 8067.2 8070.9 8073.0 06:16:34 INFO - 2015-10-23 06:16:34,635 DEBUG : BROWSER_OUTPUT: 06:16:34 INFO - 2015-10-23 06:16:34,635 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5113.07 Median:5802.99 stddev:1463.34 (25.2%) stddev-sans-first:1423.54 06:16:34 INFO - 2015-10-23 06:16:34,636 DEBUG : BROWSER_OUTPUT: Values: 373.1 380.8 381.4 383.6 386.2 5729.5 5801.7 5803.7 5815.5 5845.6 5681.7 5750.1 5766.4 5787.0 5792.1 4564.7 4588.6 4596.6 4597.7 4599.4 4449.2 4517.7 4535.4 4595.4 4607.5 4556.9 4557.1 4563.7 4570.8 4576.9 4538.0 4551.0 4557.1 4558.6 4561.6 4097.1 4098.4 4099.5 4101.7 4102.2 5465.1 5516.4 5528.5 5559.4 5564.9 5131.0 5132.2 5135.6 5138.1 5142.1 5747.3 5962.5 5968.9 5969.9 5970.6 4259.5 4281.6 4333.0 4335.1 4337.2 6087.3 6140.9 6142.5 6147.9 6173.4 4456.7 4457.4 4460.4 4464.6 4475.7 4481.7 4522.4 4527.7 4528.7 4593.9 5177.2 5178.5 5181.9 5183.1 5184.9 6074.4 6079.6 6081.5 6084.8 6085.9 1633.4 1650.3 1652.4 1653.3 1653.8 1118.0 1128.5 1156.7 1157.3 1158.2 5796.3 5802.3 5830.0 5832.5 5839.8 6160.6 6198.5 6199.4 6202.1 6226.6 5786.4 5817.7 5826.3 5831.4 5834.9 3305.4 3385.2 3415.6 3416.4 3416.6 6399.3 6414.2 6422.6 6425.7 6427.0 6282.6 6289.6 6292.1 6293.5 6296.3 6259.9 6419.9 6420.3 6429.5 6436.2 5999.3 6083.9 6206.6 6214.6 6218.8 6061.0 6099.1 6113.7 6123.8 6140.6 6377.9 6380.2 6380.8 6383.2 6383.5 4439.8 4518.4 4519.5 4528.7 4530.8 6140.2 6199.3 6232.1 6240.3 6242.3 6075.9 6076.1 6077.9 6079.3 6080.4 6043.7 6055.6 6060.1 6061.2 6062.1 5818.1 5925.2 5933.6 5934.3 5941.1 6008.9 6052.3 6054.8 6055.5 6067.3 5925.1 5929.9 5930.6 5937.7 5939.1 06:16:34 INFO - 2015-10-23 06:16:34,636 DEBUG : BROWSER_OUTPUT: 06:16:34 INFO - 2015-10-23 06:16:34,636 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12243.08 Median:487.84 stddev:13245.74 (2715.2%) stddev-sans-first:13254.79 06:16:34 INFO - 2015-10-23 06:16:34,636 DEBUG : BROWSER_OUTPUT: Values: 753.4 774.1 807.7 813.8 842.0 13034.5 13349.8 13353.5 13353.9 13353.9 12214.5 12305.2 12305.8 12312.8 12317.3 677.8 678.3 819.1 828.0 828.2 830.0 831.7 836.9 837.5 838.3 704.5 864.3 868.2 868.6 869.0 704.2 845.2 861.5 861.8 862.2 644.2 644.2 644.4 645.2 645.5 12473.7 12583.5 12595.9 12606.5 12675.3 11064.2 11139.8 11365.7 11523.2 11626.5 9586.2 9702.2 9741.0 9798.5 9932.0 3381.3 3523.8 3572.0 3598.2 3603.7 39502.8 39506.4 39652.0 39668.8 39714.2 9401.1 9573.4 9577.2 9723.6 9729.3 17600.1 17665.6 17678.5 17679.7 17682.3 7410.3 7568.4 7584.5 7637.8 7699.1 4200.5 4241.7 4261.3 4334.5 4381.4 3000.9 3032.6 3033.1 3036.4 3134.2 484.2 491.5 497.1 502.4 502.8 532.7 578.6 627.5 659.0 682.7 8574.4 8617.8 8749.3 8756.8 9074.9 555.7 665.6 680.2 694.0 694.6 3951.7 4068.9 4135.0 4182.2 4275.7 49686.0 50605.2 50691.5 50742.7 50748.0 42984.0 43319.0 43362.8 43377.1 43870.3 37656.0 38068.0 38187.0 38282.0 38377.8 8228.4 8277.8 8305.9 8325.0 8395.9 25970.9 26348.2 26568.9 26765.6 26828.2 35762.6 36575.8 37047.6 37699.8 37705.2 7967.9 8086.7 8105.8 8131.8 8265.8 11682.2 11821.7 11833.2 11837.2 12452.2 11400.1 11416.2 11563.6 11683.2 11869.9 11161.1 11375.3 11490.8 11682.2 11813.8 10551.3 10995.7 11235.9 11262.3 11644.3 9347.5 9434.1 9444.7 9627.5 9756.8 8702.8 9163.0 9264.2 9499.7 9749.5 06:16:34 INFO - 2015-10-23 06:16:34,636 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:16:34 INFO - 2015-10-23 06:16:34,636 DEBUG : BROWSER_OUTPUT: 06:16:35 INFO - 2015-10-23 06:16:35,205 INFO : Browser exited with error code: 0 06:16:35 INFO - 2015-10-23 06:16:35,226 INFO : Completed test dromaeo_css (00:18:34) 06:16:35 INFO - 2015-10-23 06:16:35,226 INFO : Starting test kraken 06:16:35 INFO - 2015-10-23 06:16:35,226 DEBUG : operating with platform_type : linux_ 06:16:35 INFO - 2015-10-23 06:16:35,226 INFO : Initialising browser for kraken test... 06:16:35 INFO - 2015-10-23 06:16:35,232 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWG8ebp/profile http://localhost:45448/getInfo.html 06:16:39 INFO - 2015-10-23 06:16:39,212 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:16:39 INFO - 2015-10-23 06:16:39,212 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:16:39 INFO - 2015-10-23 06:16:39,212 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:16:39 INFO - 2015-10-23 06:16:39,212 DEBUG : BROWSER_OUTPUT: __metrics 06:16:39 INFO - 2015-10-23 06:16:39,389 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:16:40 INFO - 2015-10-23 06:16:40,501 INFO : Browser initialized. 06:16:40 INFO - 2015-10-23 06:16:40,502 INFO : Running cycle 1/1 for kraken test... 06:16:40 INFO - 2015-10-23 06:16:40,502 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWG8ebp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:16:52 INFO - 2015-10-23 06:16:52,186 DEBUG : BROWSER_OUTPUT: RSS: Main: 142131200 06:16:52 INFO - 2015-10-23 06:16:52,186 DEBUG : BROWSER_OUTPUT: 06:16:54 INFO - 2015-10-23 06:16:54,661 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45448/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45448/tests/kraken/driver.html?testName=audio-beat-detection) 06:16:55 INFO - 2015-10-23 06:16:55,232 DEBUG : BROWSER_OUTPUT: RSS: Main: 178167808 06:16:55 INFO - 2015-10-23 06:16:55,232 DEBUG : BROWSER_OUTPUT: 06:16:57 INFO - 2015-10-23 06:16:57,632 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45448/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45448/tests/kraken/driver.html?testName=audio-dft) 06:16:58 INFO - 2015-10-23 06:16:58,198 DEBUG : BROWSER_OUTPUT: RSS: Main: 162856960 06:16:58 INFO - 2015-10-23 06:16:58,198 DEBUG : BROWSER_OUTPUT: 06:17:01 INFO - 2015-10-23 06:17:01,028 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45448/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45448/tests/kraken/driver.html?testName=audio-fft) 06:17:01 INFO - 2015-10-23 06:17:01,581 DEBUG : BROWSER_OUTPUT: RSS: Main: 150749184 06:17:01 INFO - 2015-10-23 06:17:01,582 DEBUG : BROWSER_OUTPUT: 06:17:03 INFO - 2015-10-23 06:17:03,397 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45448/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45448/tests/kraken/driver.html?testName=audio-oscillator) 06:17:03 INFO - 2015-10-23 06:17:03,964 DEBUG : BROWSER_OUTPUT: RSS: Main: 154398720 06:17:03 INFO - 2015-10-23 06:17:03,964 DEBUG : BROWSER_OUTPUT: 06:17:06 INFO - 2015-10-23 06:17:06,103 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45448/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45448/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:17:06 INFO - 2015-10-23 06:17:06,657 DEBUG : BROWSER_OUTPUT: RSS: Main: 151154688 06:17:06 INFO - 2015-10-23 06:17:06,657 DEBUG : BROWSER_OUTPUT: 06:17:09 INFO - 2015-10-23 06:17:09,557 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45448/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45448/tests/kraken/driver.html?testName=imaging-darkroom) 06:17:10 INFO - 2015-10-23 06:17:10,119 DEBUG : BROWSER_OUTPUT: RSS: Main: 154152960 06:17:10 INFO - 2015-10-23 06:17:10,119 DEBUG : BROWSER_OUTPUT: 06:17:13 INFO - 2015-10-23 06:17:13,500 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45448/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45448/tests/kraken/driver.html?testName=imaging-desaturate) 06:17:14 INFO - 2015-10-23 06:17:14,062 DEBUG : BROWSER_OUTPUT: RSS: Main: 159535104 06:17:14 INFO - 2015-10-23 06:17:14,062 DEBUG : BROWSER_OUTPUT: 06:17:16 INFO - 2015-10-23 06:17:16,784 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45448/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45448/tests/kraken/driver.html?testName=json-parse-financial) 06:17:17 INFO - 2015-10-23 06:17:17,357 DEBUG : BROWSER_OUTPUT: RSS: Main: 159535104 06:17:17 INFO - 2015-10-23 06:17:17,357 DEBUG : BROWSER_OUTPUT: 06:17:18 INFO - 2015-10-23 06:17:18,886 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45448/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45448/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:17:19 INFO - 2015-10-23 06:17:19,448 DEBUG : BROWSER_OUTPUT: RSS: Main: 164753408 06:17:20 INFO - 2015-10-23 06:17:19,448 DEBUG : BROWSER_OUTPUT: 06:17:21 INFO - 2015-10-23 06:17:21,222 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45448/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45448/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:17:21 INFO - 2015-10-23 06:17:21,796 DEBUG : BROWSER_OUTPUT: RSS: Main: 168128512 06:17:21 INFO - 2015-10-23 06:17:21,796 DEBUG : BROWSER_OUTPUT: 06:17:23 INFO - 2015-10-23 06:17:23,833 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45448/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45448/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:17:24 INFO - 2015-10-23 06:17:24,399 DEBUG : BROWSER_OUTPUT: RSS: Main: 175558656 06:17:24 INFO - 2015-10-23 06:17:24,399 DEBUG : BROWSER_OUTPUT: 06:17:27 INFO - 2015-10-23 06:17:27,246 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45448/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45448/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:17:27 INFO - 2015-10-23 06:17:27,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 185278464 06:17:27 INFO - 2015-10-23 06:17:27,819 DEBUG : BROWSER_OUTPUT: 06:17:30 INFO - 2015-10-23 06:17:30,282 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45448/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45448/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:17:30 INFO - 2015-10-23 06:17:30,850 DEBUG : BROWSER_OUTPUT: RSS: Main: 182063104 06:17:30 INFO - 2015-10-23 06:17:30,850 DEBUG : BROWSER_OUTPUT: 06:17:32 INFO - 2015-10-23 06:17:32,501 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45448/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45448/tests/kraken/driver.html?testName=ai-astar) 06:17:32 INFO - 2015-10-23 06:17:32,750 DEBUG : BROWSER_OUTPUT: RSS: Main: 234508288 06:17:32 INFO - 2015-10-23 06:17:32,750 DEBUG : BROWSER_OUTPUT: 06:17:32 INFO - 2015-10-23 06:17:32,751 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:17:32 INFO - 2015-10-23 06:17:32,751 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:17:32 INFO - 2015-10-23 06:17:32,752 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:17:32 INFO - 2015-10-23 06:17:32,752 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:17:32 INFO - 2015-10-23 06:17:32,752 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;109;106;109;111;110;100;110;108;102 06:17:32 INFO - 2015-10-23 06:17:32,752 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;126;118;127;134;122;120;125;123;138;120 06:17:32 INFO - 2015-10-23 06:17:32,753 DEBUG : BROWSER_OUTPUT: |2;audio-dft;158;159;160;158;159;159;158;159;160;157 06:17:32 INFO - 2015-10-23 06:17:32,753 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;69;69;77;71;68;69;74;76;70 06:17:32 INFO - 2015-10-23 06:17:32,753 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;132;90;91;91;132;90;91;132 06:17:32 INFO - 2015-10-23 06:17:32,753 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;110;110;110;109;110;110;109 06:17:32 INFO - 2015-10-23 06:17:32,754 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;144;145;145;146;146;145;144;144;146 06:17:32 INFO - 2015-10-23 06:17:32,754 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;97;96;95;95;96;96;96 06:17:32 INFO - 2015-10-23 06:17:32,754 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;56;59;56;57;57;58;67;55;56 06:17:32 INFO - 2015-10-23 06:17:32,754 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;67;67;67;66;67;69;66;66;66 06:17:32 INFO - 2015-10-23 06:17:32,755 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;82;91;84;82;88;83;82;83;83 06:17:32 INFO - 2015-10-23 06:17:32,755 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;118;112;110;114;120;126;121;110;119 06:17:32 INFO - 2015-10-23 06:17:32,755 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;139;140;139;145;141;141;139;139;140 06:17:32 INFO - 2015-10-23 06:17:32,755 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;64;67;65;64;64;65;66;66;65 06:17:32 INFO - 2015-10-23 06:17:32,755 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:17:32 INFO - 2015-10-23 06:17:32,756 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:17:32 INFO - 2015-10-23 06:17:32,756 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,832 06:17:32 INFO - 2015-10-23 06:17:32,756 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:17:32 INFO - 2015-10-23 06:17:32,756 DEBUG : BROWSER_OUTPUT: __startTimestamp1445606252749__endTimestamp 06:17:32 INFO - 2015-10-23 06:17:32,757 DEBUG : BROWSER_OUTPUT: 06:17:32 INFO - 2015-10-23 06:17:32,758 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:17:32 INFO - 2015-10-23 06:17:32,758 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:17:32 INFO - 2015-10-23 06:17:32,758 DEBUG : BROWSER_OUTPUT: 06:17:32 INFO - 2015-10-23 06:17:32,758 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.50 Median:109.50 stddev:3.72 (3.4%) stddev-sans-first:3.83 06:17:32 INFO - 2015-10-23 06:17:32,758 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 106.0 109.0 111.0 110.0 100.0 110.0 108.0 102.0 06:17:32 INFO - 2015-10-23 06:17:32,758 DEBUG : BROWSER_OUTPUT: 06:17:32 INFO - 2015-10-23 06:17:32,759 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:125.30 Median:125.50 stddev:6.38 (5.1%) stddev-sans-first:6.76 06:17:32 INFO - 2015-10-23 06:17:32,759 DEBUG : BROWSER_OUTPUT: Values: 126.0 118.0 127.0 134.0 122.0 120.0 125.0 123.0 138.0 120.0 06:17:32 INFO - 2015-10-23 06:17:32,759 DEBUG : BROWSER_OUTPUT: 06:17:32 INFO - 2015-10-23 06:17:32,759 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:158.70 Median:159.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 06:17:32 INFO - 2015-10-23 06:17:32,759 DEBUG : BROWSER_OUTPUT: Values: 158.0 159.0 160.0 158.0 159.0 159.0 158.0 159.0 160.0 157.0 06:17:32 INFO - 2015-10-23 06:17:32,759 DEBUG : BROWSER_OUTPUT: 06:17:32 INFO - 2015-10-23 06:17:32,759 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:71.30 Median:70.50 stddev:3.20 (4.5%) stddev-sans-first:3.36 06:17:32 INFO - 2015-10-23 06:17:32,759 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 69.0 77.0 71.0 68.0 69.0 74.0 76.0 70.0 06:17:32 INFO - 2015-10-23 06:17:32,759 DEBUG : BROWSER_OUTPUT: 06:17:32 INFO - 2015-10-23 06:17:32,760 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.30 Median:91.00 stddev:19.82 (21.8%) stddev-sans-first:20.59 06:17:32 INFO - 2015-10-23 06:17:32,760 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 132.0 90.0 91.0 91.0 132.0 90.0 91.0 132.0 06:17:32 INFO - 2015-10-23 06:17:32,760 DEBUG : BROWSER_OUTPUT: 06:17:32 INFO - 2015-10-23 06:17:32,760 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 06:17:32 INFO - 2015-10-23 06:17:32,760 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 110.0 110.0 110.0 109.0 110.0 110.0 109.0 06:17:32 INFO - 2015-10-23 06:17:32,760 DEBUG : BROWSER_OUTPUT: 06:17:32 INFO - 2015-10-23 06:17:32,760 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 06:17:32 INFO - 2015-10-23 06:17:32,760 DEBUG : BROWSER_OUTPUT: Values: 145.0 144.0 145.0 145.0 146.0 146.0 145.0 144.0 144.0 146.0 06:17:32 INFO - 2015-10-23 06:17:32,760 DEBUG : BROWSER_OUTPUT: 06:17:32 INFO - 2015-10-23 06:17:32,761 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 06:17:32 INFO - 2015-10-23 06:17:32,761 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 97.0 96.0 95.0 95.0 96.0 96.0 96.0 06:17:32 INFO - 2015-10-23 06:17:32,761 DEBUG : BROWSER_OUTPUT: 06:17:32 INFO - 2015-10-23 06:17:32,761 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.00 Median:57.50 stddev:3.43 (6.0%) stddev-sans-first:3.62 06:17:32 INFO - 2015-10-23 06:17:32,761 DEBUG : BROWSER_OUTPUT: Values: 59.0 56.0 59.0 56.0 57.0 57.0 58.0 67.0 55.0 56.0 06:17:32 INFO - 2015-10-23 06:17:32,761 DEBUG : BROWSER_OUTPUT: 06:17:32 INFO - 2015-10-23 06:17:32,761 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.99 (1.5%) stddev-sans-first:0.97 06:17:32 INFO - 2015-10-23 06:17:32,761 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 67.0 67.0 66.0 67.0 69.0 66.0 66.0 66.0 06:17:32 INFO - 2015-10-23 06:17:32,761 DEBUG : BROWSER_OUTPUT: 06:17:32 INFO - 2015-10-23 06:17:32,762 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.00 stddev:3.14 (3.8%) stddev-sans-first:3.15 06:17:32 INFO - 2015-10-23 06:17:32,762 DEBUG : BROWSER_OUTPUT: Values: 81.0 82.0 91.0 84.0 82.0 88.0 83.0 82.0 83.0 83.0 06:17:32 INFO - 2015-10-23 06:17:32,762 DEBUG : BROWSER_OUTPUT: 06:17:32 INFO - 2015-10-23 06:17:32,762 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:116.60 Median:118.50 stddev:5.19 (4.4%) stddev-sans-first:5.50 06:17:32 INFO - 2015-10-23 06:17:32,762 DEBUG : BROWSER_OUTPUT: Values: 116.0 118.0 112.0 110.0 114.0 120.0 126.0 121.0 110.0 119.0 06:17:32 INFO - 2015-10-23 06:17:32,762 DEBUG : BROWSER_OUTPUT: 06:17:32 INFO - 2015-10-23 06:17:32,762 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.10 Median:140.00 stddev:1.97 (1.4%) stddev-sans-first:1.94 06:17:32 INFO - 2015-10-23 06:17:32,762 DEBUG : BROWSER_OUTPUT: Values: 138.0 139.0 140.0 139.0 145.0 141.0 141.0 139.0 139.0 140.0 06:17:32 INFO - 2015-10-23 06:17:32,762 DEBUG : BROWSER_OUTPUT: 06:17:32 INFO - 2015-10-23 06:17:32,763 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.50 stddev:1.03 (1.6%) stddev-sans-first:1.05 06:17:32 INFO - 2015-10-23 06:17:32,763 DEBUG : BROWSER_OUTPUT: Values: 66.0 64.0 67.0 65.0 64.0 64.0 65.0 66.0 66.0 65.0 06:17:32 INFO - 2015-10-23 06:17:32,763 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:17:32 INFO - 2015-10-23 06:17:32,763 DEBUG : BROWSER_OUTPUT: 06:17:33 INFO - 2015-10-23 06:17:33,489 INFO : Browser exited with error code: 0 06:17:33 INFO - 2015-10-23 06:17:33,537 INFO : Completed test kraken (00:00:58) 06:17:33 INFO - 2015-10-23 06:17:33,537 INFO : Starting test v8_7 06:17:33 INFO - 2015-10-23 06:17:33,537 DEBUG : operating with platform_type : linux_ 06:17:33 INFO - 2015-10-23 06:17:33,537 INFO : Initialising browser for v8_7 test... 06:17:33 INFO - 2015-10-23 06:17:33,543 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpE7wKbp/profile http://localhost:45448/getInfo.html 06:17:37 INFO - 2015-10-23 06:17:37,694 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:17:37 INFO - 2015-10-23 06:17:37,695 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:17:37 INFO - 2015-10-23 06:17:37,695 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:17:37 INFO - 2015-10-23 06:17:37,695 DEBUG : BROWSER_OUTPUT: __metrics 06:17:37 INFO - 2015-10-23 06:17:37,852 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:17:39 INFO - 2015-10-23 06:17:39,064 INFO : Browser initialized. 06:17:39 INFO - 2015-10-23 06:17:39,065 INFO : Running cycle 1/1 for v8_7 test... 06:17:39 INFO - 2015-10-23 06:17:39,065 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpE7wKbp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:17:50 INFO - 2015-10-23 06:17:50,821 DEBUG : BROWSER_OUTPUT: RSS: Main: 141991936 06:17:50 INFO - 2015-10-23 06:17:50,822 DEBUG : BROWSER_OUTPUT: 06:18:12 INFO - 2015-10-23 06:18:12,257 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45448/tests/v8_7/run.html (next: http://localhost:45448/tests/v8_7/run.html) 06:18:12 INFO - 2015-10-23 06:18:12,515 DEBUG : BROWSER_OUTPUT: RSS: Main: 619290624 06:18:12 INFO - 2015-10-23 06:18:12,515 DEBUG : BROWSER_OUTPUT: 06:18:12 INFO - 2015-10-23 06:18:12,516 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:18:12 INFO - 2015-10-23 06:18:12,516 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:18:12 INFO - 2015-10-23 06:18:12,516 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:18:12 INFO - 2015-10-23 06:18:12,516 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:18:12 INFO - 2015-10-23 06:18:12,516 DEBUG : BROWSER_OUTPUT: |0;Richards;163.05233980107616 06:18:12 INFO - 2015-10-23 06:18:12,516 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.56691700365877 06:18:12 INFO - 2015-10-23 06:18:12,516 DEBUG : BROWSER_OUTPUT: |2;Encrypt;283.7684449489217 06:18:12 INFO - 2015-10-23 06:18:12,516 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5045.226130653266 06:18:12 INFO - 2015-10-23 06:18:12,516 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1939.922480620155 06:18:12 INFO - 2015-10-23 06:18:12,517 DEBUG : BROWSER_OUTPUT: |5;Earley;794.2811755361398 06:18:12 INFO - 2015-10-23 06:18:12,517 DEBUG : BROWSER_OUTPUT: |6;Boyer;11420.454545454546 06:18:12 INFO - 2015-10-23 06:18:12,517 DEBUG : BROWSER_OUTPUT: |7;RegExp;25375 06:18:12 INFO - 2015-10-23 06:18:12,517 DEBUG : BROWSER_OUTPUT: |8;Splay;611.4494518879416 06:18:12 INFO - 2015-10-23 06:18:12,517 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 06:18:12 INFO - 2015-10-23 06:18:12,517 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:18:12 INFO - 2015-10-23 06:18:12,517 DEBUG : BROWSER_OUTPUT: __startTimestamp1445606292508__endTimestamp 06:18:12 INFO - 2015-10-23 06:18:12,517 DEBUG : BROWSER_OUTPUT: 06:18:12 INFO - 2015-10-23 06:18:12,517 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:18:12 INFO - 2015-10-23 06:18:12,517 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:18:12 INFO - 2015-10-23 06:18:12,517 DEBUG : BROWSER_OUTPUT: 06:18:12 INFO - 2015-10-23 06:18:12,517 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.05 Median:163.05 stddev:0.00 (0.0%) 06:18:12 INFO - 2015-10-23 06:18:12,517 DEBUG : BROWSER_OUTPUT: Values: 163.1 06:18:12 INFO - 2015-10-23 06:18:12,517 DEBUG : BROWSER_OUTPUT: 06:18:12 INFO - 2015-10-23 06:18:12,517 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.57 Median:192.57 stddev:0.00 (0.0%) 06:18:12 INFO - 2015-10-23 06:18:12,517 DEBUG : BROWSER_OUTPUT: Values: 192.6 06:18:12 INFO - 2015-10-23 06:18:12,518 DEBUG : BROWSER_OUTPUT: 06:18:12 INFO - 2015-10-23 06:18:12,518 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:283.77 Median:283.77 stddev:0.00 (0.0%) 06:18:12 INFO - 2015-10-23 06:18:12,518 DEBUG : BROWSER_OUTPUT: Values: 283.8 06:18:12 INFO - 2015-10-23 06:18:12,518 DEBUG : BROWSER_OUTPUT: 06:18:12 INFO - 2015-10-23 06:18:12,518 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5045.23 Median:5045.23 stddev:0.00 (0.0%) 06:18:12 INFO - 2015-10-23 06:18:12,518 DEBUG : BROWSER_OUTPUT: Values: 5045.2 06:18:12 INFO - 2015-10-23 06:18:12,518 DEBUG : BROWSER_OUTPUT: 06:18:12 INFO - 2015-10-23 06:18:12,518 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1939.92 Median:1939.92 stddev:0.00 (0.0%) 06:18:12 INFO - 2015-10-23 06:18:12,518 DEBUG : BROWSER_OUTPUT: Values: 1939.9 06:18:12 INFO - 2015-10-23 06:18:12,518 DEBUG : BROWSER_OUTPUT: 06:18:12 INFO - 2015-10-23 06:18:12,518 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:794.28 Median:794.28 stddev:0.00 (0.0%) 06:18:12 INFO - 2015-10-23 06:18:12,518 DEBUG : BROWSER_OUTPUT: Values: 794.3 06:18:12 INFO - 2015-10-23 06:18:12,518 DEBUG : BROWSER_OUTPUT: 06:18:12 INFO - 2015-10-23 06:18:12,518 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11420.45 Median:11420.45 stddev:0.00 (0.0%) 06:18:12 INFO - 2015-10-23 06:18:12,518 DEBUG : BROWSER_OUTPUT: Values: 11420.5 06:18:12 INFO - 2015-10-23 06:18:12,518 DEBUG : BROWSER_OUTPUT: 06:18:12 INFO - 2015-10-23 06:18:12,519 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25375.00 Median:25375.00 stddev:0.00 (0.0%) 06:18:12 INFO - 2015-10-23 06:18:12,519 DEBUG : BROWSER_OUTPUT: Values: 25375.0 06:18:12 INFO - 2015-10-23 06:18:12,519 DEBUG : BROWSER_OUTPUT: 06:18:12 INFO - 2015-10-23 06:18:12,519 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:611.45 Median:611.45 stddev:0.00 (0.0%) 06:18:12 INFO - 2015-10-23 06:18:12,519 DEBUG : BROWSER_OUTPUT: Values: 611.4 06:18:12 INFO - 2015-10-23 06:18:12,519 DEBUG : BROWSER_OUTPUT: 06:18:12 INFO - 2015-10-23 06:18:12,519 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 06:18:12 INFO - 2015-10-23 06:18:12,519 DEBUG : BROWSER_OUTPUT: Values: 4822.1 06:18:12 INFO - 2015-10-23 06:18:12,519 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:18:12 INFO - 2015-10-23 06:18:12,519 DEBUG : BROWSER_OUTPUT: 06:18:13 INFO - 2015-10-23 06:18:13,257 INFO : Browser exited with error code: 0 06:18:13 INFO - 2015-10-23 06:18:13,271 INFO : Completed test v8_7 (00:00:39) 06:18:13 INFO - 2015-10-23 06:18:13,529 INFO : Completed test suite (00:20:12) 06:18:13 INFO - 2015-10-23 06:18:13,530 DEBUG : Working with test: dromaeo_css 06:18:13 INFO - 2015-10-23 06:18:13,530 DEBUG : Generating results file: dromaeo_css 06:18:13 INFO - 2015-10-23 06:18:13,531 DEBUG : Working with test: kraken 06:18:13 INFO - 2015-10-23 06:18:13,531 DEBUG : Generating results file: kraken 06:18:13 INFO - 2015-10-23 06:18:13,531 INFO : javascript benchmark 06:18:13 INFO - 2015-10-23 06:18:13,531 DEBUG : Working with test: v8_7 06:18:13 INFO - 2015-10-23 06:18:13,531 DEBUG : Generating results file: v8_7 06:18:13 INFO - 2015-10-23 06:18:13,532 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:18:14 INFO - 2015-10-23 06:18:14,299 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 06:18:14 INFO - 2015-10-23 06:18:14,299 DEBUG : process_Request line: dromaeo_css 6946.65 graph.html#tests=[[72,1,35]] 06:18:14 INFO - 2015-10-23 06:18:14,299 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:18:15 INFO - 2015-10-23 06:18:15,317 DEBUG : process_Request line: kraken 1447.30 graph.html#tests=[[232,1,35]] 06:18:15 INFO - 2015-10-23 06:18:15,318 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:18:16 INFO - 2015-10-23 06:18:16,360 DEBUG : process_Request line: v8_7 20049.34 graph.html#tests=[[230,1,35]] 06:18:16 INFO - 2015-10-23 06:18:16,361 INFO : javascript benchmark 06:18:16 INFO - 2015-10-23 06:18:16,365 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [397.97413168144067, 398.9780562069085, 401.5161730115211, 404.8481819317755, 405.3736976371506, 11061.668149955494, 11421.657350279484, 17091.0, 17515.64968700625, 17532.21105050274, 12186.81719774204, 12199.0, 12238.75522489552, 12352.505899763999, 12701.682457938534, 4594.10414969082, 4683.180443422404, 4694.765261736917, 4696.459907110692, 4698.154332220199, 3679.208970071434, 3769.7172712046568, 4590.5409459054, 5059.797608095671, 5177.45636708144, 5130.127878260705, 5134.7432628368615, 5135.127028405162, 5138.203578445347, 5151.45909679482, 4989.251612258154, 5093.847184584469, 5159.071367153911, 5159.277701121846, 5164.483551644843, 4492.663050271242, 4513.300438432048, 4523.773811309455, 4532.501424843264, 4536.682432229745, 14107.647308817259, 14350.784738228935, 14360.210188439632, 14368.353424095942, 14784.852151478455, 2005.6991451282424, 2047.0890453748088, 2136.8504204705678, 2174.717286752728, 2260.400993736661, 10172.542235599416, 10269.435181065039, 10318.380897146195, 10544.10375118116, 10601.946990265076, 1764.8941063536101, 1765.7439671247726, 1770.7697999260142, 1877.8873267603988, 1893.072394526672, 63601.36398636047, 63613.68193159051, 64528.0, 66439.33560664428, 67344.66327668379, 7325.926740732631, 7336.082989626297, 7352.0, 7352.772614236105, 7404.666789994463, 8792.42849214799, 8843.734687959372, 8859.734207973772, 8863.290936725047, 8913.420627659181, 5651.57613179005, 5745.798897038583, 5775.8556036099435, 5819.679917604572, 5820.214271073435, 5928.0, 5974.3428222895445, 5982.9401705983255, 6022.217111775529, 6026.578139530191, 3483.6690514401093, 3490.528778614905, 3495.8252087395526, 3516.9648303516637, 3519.3841077811794, 1223.6757259326287, 1244.3156264054733, 1274.9171303865219, 1301.9349032548334, 1314.9808898104045, 467.483430808958, 468.19937906180814, 485.6479052686774, 489.4664815351213, 496.7863818558055, 12013.0, 12069.758604827854, 12082.697932551757, 12093.818592721116, 13035.348232588522, 468.981240750373, 486.9561739443467, 502.28675281100925, 502.64563482744575, 514.3801718928682, 6712.194536655535, 6835.07726456922, 6924.376806087476, 6959.965200174068, 7010.158780946319, 570427.0, 570453.0, 573467.0, 574104.0, 582003.0, 78347.0, 81330.18669813345, 81421.0, 82558.58720706477, 82873.58563207145, 535.5501378841792, 543.6248988198209, 545.280230096277, 547.0426753181931, 547.0918275662382, 11627.825582616098, 11674.533018679158, 11973.76052478963, 12007.039436844856, 12021.038316934799, 34755.30489390249, 34980.67683570057, 35034.24828758501, 35226.47160292546, 36416.45375319319, 46396.0, 50236.246456302455, 50877.49122508727, 52770.0, 52847.47152528426, 6791.04925310447, 6799.932000680128, 6803.0, 6859.108315918898, 6865.107536020485, 12945.640707725554, 13166.144200626928, 13435.261060641758, 13449.731005380034, 13455.798163027759, 10978.505967231335, 11228.4385780709, 11394.829077563678, 11422.885771142182, 11491.367974761468, 10616.946915265375, 10927.39899305514, 11089.50097245642, 11151.832722509007, 11331.603393881174, 11147.0, 11225.494852731483, 11306.265092768943, 11359.602413915472, 11410.714732131763, 6953.304669533209, 7282.453815963718, 7381.889271661037, 7384.224656410999, 7396.14944281393, 10569.63006294776, 10876.836847447454, 11133.332000080021, 11337.093032557541, 11431.085513159094], "dojo.html": [3262.3149138680874, 3336.8164750938718, 3358.6641335866416, 3361.210115622829, 3363.529105925171, 5487.341519017724, 5585.190147428621, 5740.483356497914, 5752.568557358194, 5768.913466298004, 5674.233978412913, 5686.289213848258, 5692.203091567184, 5693.402192769761, 5764.337101233359, 5187.792488300483, 5193.091209038422, 5220.060389129955, 5230.607704422165, 5236.7905283788605, 5147.974260128694, 5163.81926632568, 5217.452167522412, 5270.736463176826, 5281.339832520935, 5000.249962505617, 5083.186690129562, 5085.440601533828, 5219.582433405338, 5220.29526013987, 5167.638265321429, 5178.4562620924635, 5194.584433245332, 5210.166373380241, 5213.973930130363, 5177.974110129463, 5197.350331208599, 5207.661502002357, 5224.52979231871, 5230.084735171368, 5347.7058761768085, 5392.757325920304, 5452.482014208644, 5499.285092937893, 5535.667859928377, 6009.939900600982, 6064.423879731463, 6070.6357618543025, 6083.878322433527, 6093.482054025413, 6095.603785753956, 6096.211917361819, 6099.359567245419, 6106.603070800384, 6107.358727333655, 5444.3194600674915, 5536.003519366513, 5560.138178582326, 5625.184348269478, 5678.432156784371, 6143.508519318533, 6156.969215153896, 6171.043488259327, 6171.475424588871, 6198.535109866778, 5732.713364331767, 5953.732082056231, 5964.970175149097, 5966.970165149147, 5969.0, 5902.026165682614, 5956.16613674086, 5986.820395388146, 5989.1914591529585, 6035.939640603538, 6044.546659000593, 6049.062395328731, 6052.969735151296, 6058.848528786727, 6073.301570319381, 5818.21454103699, 5951.464368206882, 6038.728257228435, 6065.605735627259, 6065.8180254592435, 4486.080353527519, 4567.086582683477, 4578.061497393026, 4596.0, 4616.28447590624, 4133.04939863833, 4142.875713728593, 4144.958550414518, 4200.159968006411, 4214.7471151731, 5433.26650902131, 5663.801766938137, 5697.373288938214, 5697.6296540724725, 5704.8859022819315, 5881.411858814085, 5919.526437884959, 6019.668918209541, 6098.058532604889, 6105.065535583899, 5710.029295019856, 5710.771569137188, 5719.370869204384, 5732.799352022659, 5761.654300741969, 4942.802287908444, 5216.530512253916, 5221.869453263699, 5225.843224703265, 5227.712475813791, 6140.293866205354, 6166.845828854314, 6302.779402720883, 6305.2433707953505, 6316.210473690789, 6067.271927368744, 6069.36271691466, 6081.118237855575, 6089.5737298388685, 6097.0, 5996.610220335664, 6098.451139397475, 6247.718852651551, 6261.405166509175, 6273.498120150286, 5863.589548731547, 5869.413058694096, 5884.382139875423, 5906.616069955439, 5954.940450595612, 5903.173555702119, 5919.556033297434, 5922.318933322723, 5938.792142275, 6022.247219097613, 5616.466435688603, 5720.513756330592, 5838.795642152504, 5848.64908105515, 5859.20900678403, 5715.542756579381, 5750.654960702372, 5767.452092051249, 5808.535317174531, 5843.211166492469, 5777.104548794943, 5783.508401785727, 5787.681677507778, 5792.536597072309, 5800.9419905800405, 5689.061304884648, 5847.210626565359, 5894.498967587803, 5913.142594323885, 5913.852153696192, 5602.215689803349, 5778.36437991829, 5782.1615865698395, 5787.334456537384, 5826.300843898759], "mootools.html": [1427.6002719238618, 1575.7951466309378, 1727.9632220667602, 1867.673157197491, 1976.5453945592512, 8137.674493020279, 9174.17432431082, 9279.907200927988, 9282.211012063974, 9283.814323713521, 9247.121523455278, 9319.627214911396, 9367.484788336638, 9385.577649005794, 9634.566444509996, 2193.3748881568754, 2231.6764069209953, 2490.651308816767, 2494.1519883239694, 2516.7609077137645, 2528.886200120999, 2564.756348146923, 2573.819832611718, 2576.716561178269, 2577.8066645001604, 2489.4523204894895, 2509.7866681332107, 2510.297116807297, 2511.259178542325, 2512.572862613351, 2135.679648052789, 2178.56428714257, 2479.8636075015866, 2579.638850560923, 2581.4062765564026, 2539.5428822811887, 2539.5682733935278, 2571.6014017827265, 2585.4312051348675, 2587.5471792436438, 9356.298277629137, 9398.67104651334, 9401.905980940172, 9411.62353505859, 9413.0, 5580.135079062711, 5682.602217844753, 5686.2039314496005, 5687.289088863892, 5687.317521897398, 3531.0, 3554.2713743682484, 3570.9642903570893, 3646.3436581415335, 3647.1793846384617, 1177.570186881782, 1182.532899504691, 1187.7683851648933, 1196.7068068323229, 1255.522901297501, 14103.0, 14231.0, 14233.572992810128, 14239.78640320396, 14242.287885605781, 5006.199008158677, 5089.592832573385, 5131.512506311894, 5155.819546315861, 5168.793248270027, 11935.820962685566, 11977.760444791229, 11992.880071199352, 11997.400129993466, 11997.880021199851, 5584.274044374205, 5586.659201791622, 5587.636803607753, 5588.636738611977, 5590.189422533791, 4868.61051115917, 4943.876403089952, 4955.083309587738, 4959.0, 4960.305557221992, 4228.921624985609, 4232.873013809591, 4244.236037513216, 4251.9787401062795, 4258.914821703611, 1337.277869950216, 1348.5280151946936, 1349.6625843539116, 1357.1043111546333, 1359.8572149924314, 1343.9126456780473, 1345.4349173347218, 1347.6563476313477, 1376.1949259682997, 1405.1779708870222, 8900.376973611914, 9118.40730352525, 9121.863172052424, 9123.498207598646, 9127.68053118151, 553.8476918847268, 565.8132816170736, 573.6386076771607, 573.7274794472592, 575.2952633024595, 6771.085903402977, 6829.282925292872, 6852.897206541906, 6874.9656251718425, 6885.345892140239, 12030.15788894769, 12198.024158067334, 12208.389580520938, 12219.450124744408, 12221.877781222074, 11757.647270581896, 11854.703632409259, 12033.278003319829, 12041.879581204252, 12129.272243665408, 8701.738947831574, 8782.736517904345, 8790.208881200722, 8796.208341249318, 8800.119988001277, 8356.289715374018, 8529.3602979778, 8553.82892342162, 8556.700515482178, 8566.82866342682, 10145.797084058426, 10252.64115755945, 10313.22650801178, 10509.632162874263, 10515.211359147941, 10590.417527036087, 10738.516766745359, 10745.623903163352, 10768.730781730206, 10769.084627806724, 8589.44168629037, 8707.782305442415, 8716.259117974789, 8734.868976965477, 8737.475751454933, 9415.435073895589, 9481.241500680067, 9489.051094890456, 9491.905080949102, 9534.0, 7595.5442673439775, 8508.234258916727, 8792.560371981248, 8879.866801997847, 9092.272618190662, 8335.95832020836, 8589.226969572768, 8601.22588966996, 8662.047174810892, 8741.0, 8534.78663033429, 8564.0, 8627.309815214894, 8647.827043459221, 8648.913510865063, 7896.210378962058, 7902.407319451179, 7928.365730741642, 7958.0848202457455, 7961.40289478303, 7952.204779522233, 7966.243206895336, 8067.233612807008, 8070.919290807017, 8072.959635202022], "ext.html": [558.4276116980097, 599.6791716431709, 606.9484093852021, 620.5532016947795, 624.9750009999594, 31378.0, 39754.80122599386, 40462.393064104064, 40501.0, 40504.79747601265, 43114.78442607783, 43580.346294805604, 43586.346204806956, 43612.0, 43642.0, 7867.016622922135, 7990.041195056601, 8998.999999999984, 9176.26589872812, 10552.630657926975, 10731.678049658523, 10762.085222756075, 10858.294210876307, 10892.673219803419, 10903.727406814853, 10721.678349649485, 10837.512311945942, 10852.07757340627, 10922.726931826688, 10966.670999869977, 8007.599620019005, 8162.469439486444, 10993.395363255018, 11271.830922536168, 11277.774444511064, 10631.362118272928, 10788.460576971198, 10799.568017279378, 10805.567777288978, 10808.459577021196, 40848.795756021325, 41403.7929810352, 41419.37870931938, 41497.585024149674, 41577.792111039555, 3239.578854748891, 3240.578724765789, 3322.750793690483, 3566.7146628269934, 4102.3026085565225, 29712.257193570116, 29989.550156747668, 30553.0, 30653.540196897065, 30662.0, 3006.383691343291, 3070.140360699008, 3090.9690903090905, 3106.7048630380077, 3122.73456756176, 295343.0, 296541.0, 296990.5150474255, 297673.0, 298868.0, 55793.442065579635, 56743.432565673815, 56848.431515685144, 57216.713916430985, 61897.21462534197, 60019.699901500215, 60259.0, 60346.698266508385, 60516.092258616154, 60543.69728151331, 15474.303656335493, 15503.302351394213, 15592.298346574431, 15592.766108508382, 15637.452689155825, 12060.819087713691, 12120.212186207867, 12124.333161676017, 12133.757324853454, 12135.63593092191, 18695.15871785773, 18893.7165942511, 18983.430497085108, 19010.61978760417, 19073.904630477038, 8302.584870756438, 8577.228049475578, 8578.270846978077, 8588.957055214683, 8612.267957223581, 873.8470767615642, 894.2130924786277, 913.6254135804288, 1004.2167109654481, 1048.8636477257908, 28846.278843029093, 28936.855315723285, 29284.26789330241, 29361.11916642504, 33677.66322336794, 1013.3919648211014, 1026.9319907296328, 1063.5054699564585, 1172.9736480579493, 1215.1493954231896, 15643.608909777347, 15784.526464205863, 15875.444359447363, 15925.442609508611, 16181.757273640906, 383629.0, 389274.0, 390133.0, 390542.0, 391359.0, 55062.724686376314, 55376.0, 55438.44561554414, 55447.722761385936, 55504.44495554993, 1316.493150137204, 1317.3939987605618, 1341.4231880291372, 1355.3358854161588, 1387.2855479428104, 28551.571726424536, 29226.269343266587, 29263.268418289714, 29619.40761184721, 29705.5544166842, 47173.52826471828, 47581.762091189325, 47595.0, 47605.0, 47666.76166619283, 307476.0, 307574.0, 307994.0, 308578.0, 309067.0, 28429.857850710614, 28846.7115328844, 32675.34649307048, 33258.50112248366, 34200.82899585586, 39443.605563945144, 39548.40677389899, 39734.60265397309, 39890.0, 40650.79674601608, 34445.65554344424, 34470.0, 35008.649913501555, 41945.37081943712, 43234.783826081926, 32237.142233770468, 38042.0, 39099.218015640094, 41206.381904270864, 42016.67264967507, 36517.26965460729, 36813.26373472569, 37564.81217593895, 37735.81132094322, 37797.62202377941, 32056.679433206304, 33152.50271245885, 35330.47004294989, 35331.41781432717, 35767.28465430625, 26367.34081647974, 26382.07662731795, 26432.339191520365, 26485.0, 26730.866345668146], "prototype.html": [373.07291380918423, 380.7962739934134, 381.3734422687241, 383.55699167461574, 386.1716617854702, 5729.455701708342, 5801.680907550078, 5803.651780893149, 5815.534757219423, 5845.620034697747, 5681.744321505532, 5750.137479378085, 5766.365699773032, 5787.045137552299, 5792.131180322943, 4564.657650676196, 4588.587027167554, 4596.632269418438, 4597.7011494252765, 4599.44806623204, 4449.17690227309, 4517.7289362638185, 4535.365048893158, 4595.402597662299, 4607.493175750665, 4556.9088618227615, 4557.08858228354, 4563.703359281636, 4570.817167313304, 4576.931346029813, 4538.047010127877, 4550.977245113786, 4557.065801510682, 4558.566936141061, 4561.635069194456, 4097.057676734368, 4098.426220329156, 4099.467069281004, 4101.692373072032, 4102.159057393227, 5465.07093794056, 5516.393196748395, 5528.5024347808485, 5559.360673522516, 5564.916526252109, 5131.025105229995, 5132.204508301219, 5135.563477104451, 5138.126518491866, 5142.125838607409, 5747.252857128588, 5962.493188079018, 5968.940310596882, 5969.925413425582, 5970.611910225864, 4259.5101563319995, 4281.636060934824, 4332.978335108304, 4335.1329734053315, 4337.1976184405985, 6087.269527656666, 6140.877182456371, 6142.508599312045, 6147.907781383283, 6173.351798061184, 4456.732596044248, 4457.375967364572, 4460.442444694413, 4464.642828573771, 4475.686701930898, 4481.731096134243, 4522.4346956630425, 4527.660425468103, 4528.728276303433, 4593.874500747338, 5177.197534382177, 5178.508041736029, 5181.948180518222, 5183.0670479314085, 5184.922226166611, 6074.42292982166, 6079.635221886701, 6081.452669259788, 6084.817455476343, 6085.878282434326, 1633.3793158599656, 1650.3233674193764, 1652.4381710218343, 1653.3138747419687, 1653.7602047703015, 1117.9608713694981, 1128.480898786551, 1156.6761306833932, 1157.2824848593925, 1158.1719070864203, 5796.275465566804, 5802.332731735904, 5830.0, 5832.533397328203, 5839.795607153814, 6160.630362178284, 6198.504119670506, 6199.380061993765, 6202.131701561785, 6226.62640241587, 5786.421357864264, 5817.7382017809305, 5826.329972053183, 5831.446012628793, 5834.883302333929, 3305.3554556861664, 3385.2044769479153, 3415.624281329052, 3416.4362880125, 3416.5558477398276, 6399.296077431479, 6414.166158399378, 6422.550421470452, 6425.74297028123, 6426.967865160645, 6282.623042617458, 6289.55973081889, 6292.119103325538, 6293.465055470337, 6296.307406185316, 6259.906101408483, 6419.903701444482, 6420.261669907927, 6429.5499315049365, 6436.227652681709, 5999.3100793407575, 6083.908741368795, 6206.627602343874, 6214.5960512566535, 6218.81343559694, 6061.0, 6099.11562823397, 6113.663748493876, 6123.785667501616, 6140.600860944024, 6377.87244255103, 6380.202474690664, 6380.776672816429, 6383.234011918599, 6383.457406120532, 4439.844605438794, 4518.43519560055, 4519.480259770037, 4528.728276303433, 4530.818767249405, 6140.17107690456, 6199.287081985449, 6232.065190221322, 6240.251169859646, 6242.344553821783, 6075.939240607714, 6076.149339092619, 6077.878442431215, 6079.300880398634, 6080.422359875804, 6043.728032238472, 6055.6063855849225, 6060.060690592965, 6061.1514387984835, 6062.120992456157, 5818.0981947798155, 5925.1704761332585, 5933.554983376178, 5934.347221805684, 5941.1385349125, 6008.87982240344, 6052.303985041601, 6054.848628784315, 6055.545834062551, 6067.271927368744, 5925.081612350093, 5929.881402372014, 5930.584859059824, 5937.673427961504, 5939.10913362999], "yui.html": [753.3972821742605, 774.1368374262698, 807.7334479621726, 813.825027619062, 841.9873701894472, 13034.543790967318, 13349.799753003712, 13353.53262635808, 13353.866461335383, 13353.866461335396, 12214.51141954323, 12305.200161989464, 12305.815412768816, 12312.753744925118, 12317.322547259897, 677.8136012596526, 678.3250665587747, 819.1153554161491, 827.9710210142646, 828.1801016993163, 829.995850020749, 831.6964308027557, 836.8744688296774, 837.4556538250125, 838.2707044870971, 704.4962851561132, 864.3344624639025, 868.179570306061, 868.552695361886, 869.0, 704.1620471638734, 845.222395396237, 861.5175501719058, 861.8147098373817, 862.2412277196028, 644.230144976753, 644.2462319086679, 644.4361183964031, 645.2160624840794, 645.5287640022763, 12473.688157796038, 12583.496660133584, 12595.874041259653, 12606.495740170381, 12675.30285834288, 11064.225504214708, 11139.777204455866, 11365.715857103556, 11523.19337646365, 11626.476808543552, 9586.185174260196, 9702.223822094216, 9741.0, 9798.461084640341, 9932.0, 3381.289929114864, 3523.7533372663925, 3572.0, 3598.1904071583945, 3603.6756691897594, 39502.802485987675, 39506.40740388897, 39652.0, 39668.801655991534, 39714.20571588552, 9401.10689484498, 9573.377730447499, 9577.23382129428, 9723.562439690231, 9729.318947673595, 17600.119994000248, 17665.558361041076, 17678.46964591064, 17679.73480397795, 17682.292708291523, 7410.296021877913, 7568.394528437711, 7584.5070070445245, 7637.752318603316, 7699.076110866732, 4200.4959404871615, 4241.745495270294, 4261.275583150872, 4334.50153232376, 4381.38660587518, 3000.8799648013833, 3032.5754394384803, 3033.1052339559883, 3036.3927214557175, 3134.200778801391, 484.16239904964607, 491.5134017322825, 497.1027295731168, 502.4322515557397, 502.7762645622736, 532.6590981771669, 578.5949835115351, 627.4823270801606, 658.9967050164719, 682.668905580793, 8574.35346969607, 8617.784555386166, 8749.25631321332, 8756.774051632776, 9074.86387704185, 555.7246120154256, 665.55075324156, 680.2415306932735, 693.968771405288, 694.583250049966, 3951.7036222283446, 4068.8575899843954, 4134.979325103355, 4182.205380977665, 4275.657947364203, 49686.0, 50605.24092138621, 50691.493085069415, 50742.74628626907, 50748.0, 42984.0, 43319.0, 43362.783186084496, 43377.13245735068, 43870.34194487085, 37656.0, 38067.99999999945, 38187.0, 38282.0, 38377.80811095927, 8228.382871284557, 8277.793055173668, 8305.916940830515, 8324.978426883355, 8395.874061889199, 25970.87014564915, 26348.20955371342, 26568.8671556641, 26765.598516022666, 26828.195154145407, 35762.64237357593, 36575.817120914224, 37047.62952370442, 37699.81150094232, 37705.245895082495, 7967.920320796949, 8086.7169649062, 8105.797355066171, 8131.837363252584, 8265.752027439186, 11682.182247242612, 11821.70445738829, 11833.230839995373, 11837.171398002058, 12452.190607610477, 11400.144989126014, 11416.200865939636, 11563.595274165364, 11683.18217724751, 11869.881301186877, 11161.051310638362, 11375.31748095117, 11490.77018459643, 11682.182247242612, 11813.763724725286, 10551.314164579278, 10995.725106872073, 11235.887641123483, 11262.267952583055, 11644.301341919512, 9347.485888275938, 9434.10301423801, 9444.716658500256, 9627.518624068629, 9756.756081097745, 8702.825943480968, 9162.954185229031, 9264.166225039779, 9499.715008549754, 9749.512524373895]}, "summary": {"suite": 6946.654525077352, "subtests": {"jquery.html": {"filtered": 7210.417393791595, "value": 7210.417393791595}, "dojo.html": {"filtered": 5551.351716238543, "value": 5551.351716238543}, "mootools.html": {"filtered": 5248.862324775345, "value": 5248.862324775345}, "ext.html": {"filtered": 19281.788140519184, "value": 19281.788140519184}, "prototype.html": {"filtered": 4661.00702128096, "value": 4661.00702128096}, "yui.html": {"filtered": 5950.6998302249685, "value": 5950.6998302249685}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-041"}, "testrun": {"date": 1445605080, "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": "44.0a1", "id": "20151023030245", "branch": "Firefox", "revision": "0625c68c0abcfe4d10880d15d8fe7d06df3369c9"}}, {"talos_counters": {}, "results": {"audio-dft": [158.0, 159.0, 160.0, 158.0, 159.0, 159.0, 158.0, 159.0, 160.0, 157.0], "ai-astar": [110.0, 109.0, 106.0, 109.0, 111.0, 110.0, 100.0, 110.0, 108.0, 102.0], "imaging-gaussian-blur": [109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0], "audio-beat-detection": [126.0, 118.0, 127.0, 134.0, 122.0, 120.0, 125.0, 123.0, 138.0, 120.0], "json-stringify-tinderbox": [68.0, 67.0, 67.0, 67.0, 66.0, 67.0, 69.0, 66.0, 66.0, 66.0], "stanford-crypto-pbkdf2": [138.0, 139.0, 140.0, 139.0, 145.0, 141.0, 141.0, 139.0, 139.0, 140.0], "json-parse-financial": [59.0, 56.0, 59.0, 56.0, 57.0, 57.0, 58.0, 67.0, 55.0, 56.0], "stanford-crypto-sha256-iterative": [66.0, 64.0, 67.0, 65.0, 64.0, 64.0, 65.0, 66.0, 66.0, 65.0], "audio-fft": [70.0, 69.0, 69.0, 77.0, 71.0, 68.0, 69.0, 74.0, 76.0, 70.0], "imaging-darkroom": [145.0, 144.0, 145.0, 145.0, 146.0, 146.0, 145.0, 144.0, 144.0, 146.0], "stanford-crypto-ccm": [116.0, 118.0, 112.0, 110.0, 114.0, 120.0, 126.0, 121.0, 110.0, 119.0], "audio-oscillator": [92.0, 92.0, 132.0, 90.0, 91.0, 91.0, 132.0, 90.0, 91.0, 132.0], "stanford-crypto-aes": [81.0, 82.0, 91.0, 84.0, 82.0, 88.0, 83.0, 82.0, 83.0, 83.0], "imaging-desaturate": [96.0, 96.0, 96.0, 97.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0]}, "summary": {"suite": 1447.3, "subtests": {"audio-fft": {"filtered": 71.3, "value": 71.3}, "stanford-crypto-pbkdf2": {"filtered": 140.1, "value": 140.1}, "audio-beat-detection": {"filtered": 125.3, "value": 125.3}, "stanford-crypto-ccm": {"filtered": 116.6, "value": 116.6}, "imaging-darkroom": {"filtered": 145.0, "value": 145.0}, "json-parse-financial": {"filtered": 58.0, "value": 58.0}, "audio-oscillator": {"filtered": 103.3, "value": 103.3}, "ai-astar": {"filtered": 107.5, "value": 107.5}, "audio-dft": {"filtered": 158.7, "value": 158.7}, "stanford-crypto-sha256-iterative": {"filtered": 65.2, "value": 65.2}, "json-stringify-tinderbox": {"filtered": 66.9, "value": 66.9}, "imaging-gaussian-blur": {"filtered": 109.6, "value": 109.6}, "stanford-crypto-aes": {"filtered": 83.9, "value": 83.9}, "imaging-desaturate": {"filtered": 95.9, "value": 95.9}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-041"}, "testrun": {"date": 1445605080, "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": "44.0a1", "id": "20151023030245", "branch": "Firefox", "revision": "0625c68c0abcfe4d10880d15d8fe7d06df3369c9"}}, {"talos_counters": {}, "results": {"DeltaBlue": [192.56691700365877], "Encrypt": [283.7684449489217], "NavierStokes": [4822.115384615385], "Decrypt": [5045.226130653266], "Splay": [611.4494518879416], "Richards": [163.05233980107616], "RegExp": [25375.0], "Earley": [794.2811755361398], "Boyer": [11420.454545454546], "RayTrace": [1939.922480620155]}, "summary": {"suite": 20049.336808374712, "subtests": {"DeltaBlue": {"filtered": 343.35077400000006, "value": 343.35077400000006}, "Encrypt": {"filtered": 938.0218440000002, "value": 938.0218440000002}, "NavierStokes": {"filtered": 307.7487537387835, "value": 307.7487537387835}, "Decrypt": {"filtered": 52.75898306772911, "value": 52.75898306772911}, "Splay": {"filtered": 133.27512151394424, "value": 133.27512151394424}, "RegExp": {"filtered": 35.90088669950742, "value": 35.90088669950742}, "Richards": {"filtered": 216.50716599999996, "value": 216.50716599999996}, "Earley": {"filtered": 839.0769169999999, "value": 839.0769169999999}, "Boyer": {"filtered": 58.356959203980146, "value": 58.356959203980146}, "RayTrace": {"filtered": 381.452871128871, "value": 381.452871128871}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-041"}, "testrun": {"date": 1445605080, "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": "44.0a1", "id": "20151023030245", "branch": "Firefox", "revision": "0625c68c0abcfe4d10880d15d8fe7d06df3369c9"}}] 06:18:16 INFO - RETURN: dromaeo_css: 6946.65 06:18:16 INFO - RETURN: kraken: 1447.30 06:18:16 INFO - RETURN: v8_7: 20049.34 06:18:16 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "20049.34"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1447.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6946.65"}}} 06:18:16 INFO - Return code: 0 06:18:16 INFO - # TBPL SUCCESS # 06:18:16 INFO - Running post-action listener: _resource_record_post_action 06:18:16 INFO - Running post-run listener: _resource_record_post_run 06:18:17 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 7979008; Write bytes: 391786496; Read time: 2104; Write time: 431164 06:18:17 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 548864; Read time: 0; Write time: 56 06:18:17 INFO - run-tests - Wall time: 1216s; CPU: 13.0%; Read bytes: 5824512; Write bytes: 391237632; Read time: 1980; Write time: 431108 06:18:17 INFO - Running post-run listener: _upload_blobber_files 06:18:17 INFO - Blob upload gear active. 06:18:17 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:18:17 INFO - Copying logs to upload dir... 06:18:17 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1499.270708 ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 59 secs) (at 2015-10-23 06:18:17.588746) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-23 06:18:17.592358) ========= 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=7f67ac1ceef7774224e327f2000001f6-1445602380.562456-627290231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009994 build_url: 'https://queue.taskcluster.net/v1/task/MEmxVziQTn6ZqMu5PPqTPA/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2' ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-23 06:18:17.643116) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-23 06:18:17.643514) ========= 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=7f67ac1ceef7774224e327f2000001f6-1445602380.562456-627290231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-23 06:18:17.694085) ========= ========= Started reboot slave lost (results: 0, elapsed: 4 secs) (at 2015-10-23 06:18:17.694424) ========= ========= Finished reboot slave lost (results: 0, elapsed: 4 secs) (at 2015-10-23 06:18:21.869635) =========