builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1447451122.67 results: success (0) buildid: 20151113113033 builduid: 884d565e292d427283aa01a1226bf477 revision: 8f4312027a498f6c89e23ab42fc3d161b2df66f0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 13:45:22.666591) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 13:45:22.670167) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 13:45:22.670634) ========= 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=ccb4611811c763f2fad71465000001de-1447450787.366734-23142978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006379 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 13:45:22.703788) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 13:45:22.704238) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 13:45:22.799866) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 13:45:22.800490) ========= 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=ccb4611811c763f2fad71465000001de-1447450787.366734-23142978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023043 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 13:45:22.866010) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 13:45:22.866327) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 13:45:22.866727) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 13:45:22.867025) ========= 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=ccb4611811c763f2fad71465000001de-1447450787.366734-23142978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-13 13:45:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 216M=0s 2015-11-13 13:45:23 (216 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.197761 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 13:45:23.079640) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 13:45:23.079963) ========= 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=ccb4611811c763f2fad71465000001de-1447450787.366734-23142978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.080473 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 13:45:23.171073) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-13 13:45:23.171430) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8f4312027a498f6c89e23ab42fc3d161b2df66f0 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 8f4312027a498f6c89e23ab42fc3d161b2df66f0 --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=ccb4611811c763f2fad71465000001de-1447450787.366734-23142978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-13 13:45:23,227 truncating revision to first 12 chars 2015-11-13 13:45:23,227 Setting DEBUG logging. 2015-11-13 13:45:23,227 attempt 1/10 2015-11-13 13:45:23,227 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8f4312027a49?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-13 13:45:24,182 unpacking tar archive at: fx-team-8f4312027a49/testing/mozharness/ program finished with exit code 0 elapsedTime=1.238363 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-13 13:45:24.423339) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 13:45:24.423638) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 13:45:24.433001) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 13:45:24.433285) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 13:45:24.433921) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2015-11-13 13:45:24.434221) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ccb4611811c763f2fad71465000001de-1447450787.366734-23142978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:45:24 INFO - MultiFileLogger online at 20151113 13:45:24 in /builds/slave/test-pgo 13:45:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 13:45:24 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:45:24 INFO - {'append_to_log': False, 13:45:24 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:45:24 INFO - 'blob_upload_branch': 'Fx-Team', 13:45:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:45:24 INFO - 'branch': 'Fx-Team', 13:45:24 INFO - 'buildbot_json_path': 'buildprops.json', 13:45:24 INFO - 'config_files': ('talos/linux_config.py',), 13:45:24 INFO - 'default_actions': ('clobber', 13:45:24 INFO - 'read-buildbot-config', 13:45:24 INFO - 'download-and-extract', 13:45:24 INFO - 'populate-webroot', 13:45:24 INFO - 'create-virtualenv', 13:45:24 INFO - 'install', 13:45:24 INFO - 'run-tests'), 13:45:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:45:24 INFO - 'download_minidump_stackwalk': True, 13:45:24 INFO - 'download_symbols': 'ondemand', 13:45:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:45:24 INFO - 'tooltool.py': '/tools/tooltool.py', 13:45:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:45:24 INFO - '/tools/misc-python/virtualenv.py')}, 13:45:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:45:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:45:24 INFO - 'installer_path': 'installer.exe', 13:45:24 INFO - 'log_level': 'info', 13:45:24 INFO - 'log_name': 'talos', 13:45:24 INFO - 'log_to_console': True, 13:45:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:45:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:45:24 INFO - 'opt_config_files': (), 13:45:24 INFO - 'pip_index': False, 13:45:24 INFO - 'sps_profile': False, 13:45:24 INFO - 'sps_profile_interval': 0, 13:45:24 INFO - 'suite': 'dromaeojs', 13:45:24 INFO - 'system_bits': '64', 13:45:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:45:24 INFO - 'title': 'talos-linux64-ix-021', 13:45:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:45:24 INFO - 'use_talos_json': True, 13:45:24 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:45:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:45:24 INFO - 'work_dir': 'build'} 13:45:24 INFO - ##### 13:45:24 INFO - ##### Running clobber step. 13:45:24 INFO - ##### 13:45:24 INFO - Running pre-action listener: _resource_record_pre_action 13:45:24 INFO - Running main action method: clobber 13:45:24 INFO - rmtree: /builds/slave/test-pgo/build 13:45:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:45:25 INFO - Running post-action listener: _resource_record_post_action 13:45:25 INFO - ##### 13:45:25 INFO - ##### Running read-buildbot-config step. 13:45:25 INFO - ##### 13:45:25 INFO - Running pre-action listener: _resource_record_pre_action 13:45:25 INFO - Running main action method: read_buildbot_config 13:45:25 INFO - Using buildbot properties: 13:45:25 INFO - { 13:45:25 INFO - "properties": { 13:45:25 INFO - "buildnumber": 486, 13:45:25 INFO - "product": "firefox", 13:45:25 INFO - "script_repo_revision": "production", 13:45:25 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:45:25 INFO - "repository": "", 13:45:25 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 13:45:25 INFO - "buildid": "20151113113033", 13:45:25 INFO - "slavename": "talos-linux64-ix-021", 13:45:25 INFO - "pgo_build": "True", 13:45:25 INFO - "basedir": "/builds/slave/test-pgo", 13:45:25 INFO - "project": "", 13:45:25 INFO - "platform": "ubuntu64_hw", 13:45:25 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:45:25 INFO - "slavebuilddir": "test", 13:45:25 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 13:45:25 INFO - "branch": "fx-team", 13:45:25 INFO - "repo_path": "integration/fx-team", 13:45:25 INFO - "stage_platform": "linux64-pgo", 13:45:25 INFO - "builduid": "884d565e292d427283aa01a1226bf477", 13:45:25 INFO - "revision": "8f4312027a498f6c89e23ab42fc3d161b2df66f0" 13:45:25 INFO - }, 13:45:25 INFO - "sourcestamp": { 13:45:25 INFO - "repository": "", 13:45:25 INFO - "hasPatch": false, 13:45:25 INFO - "project": "", 13:45:25 INFO - "branch": "fx-team-linux64-pgo-talos", 13:45:25 INFO - "changes": [ 13:45:25 INFO - { 13:45:25 INFO - "category": null, 13:45:25 INFO - "files": [ 13:45:25 INFO - { 13:45:25 INFO - "url": null, 13:45:25 INFO - "name": "https://queue.taskcluster.net/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 13:45:25 INFO - } 13:45:25 INFO - ], 13:45:25 INFO - "repository": "", 13:45:25 INFO - "rev": "8f4312027a498f6c89e23ab42fc3d161b2df66f0", 13:45:25 INFO - "who": "sendchange", 13:45:25 INFO - "when": 1447451100, 13:45:25 INFO - "number": 6660519, 13:45:25 INFO - "comments": "", 13:45:25 INFO - "project": "", 13:45:25 INFO - "at": "Fri 13 Nov 2015 13:45:00", 13:45:25 INFO - "branch": "fx-team-linux64-pgo-talos", 13:45:25 INFO - "revlink": "", 13:45:25 INFO - "properties": [ 13:45:25 INFO - [ 13:45:25 INFO - "buildid", 13:45:25 INFO - "20151113113033", 13:45:25 INFO - "Change" 13:45:25 INFO - ], 13:45:25 INFO - [ 13:45:25 INFO - "builduid", 13:45:25 INFO - "884d565e292d427283aa01a1226bf477", 13:45:25 INFO - "Change" 13:45:25 INFO - ], 13:45:25 INFO - [ 13:45:25 INFO - "pgo_build", 13:45:25 INFO - "True", 13:45:25 INFO - "Change" 13:45:25 INFO - ] 13:45:25 INFO - ], 13:45:25 INFO - "revision": "8f4312027a498f6c89e23ab42fc3d161b2df66f0" 13:45:25 INFO - } 13:45:25 INFO - ], 13:45:25 INFO - "revision": "8f4312027a498f6c89e23ab42fc3d161b2df66f0" 13:45:25 INFO - } 13:45:25 INFO - } 13:45:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 13:45:25 INFO - Running post-action listener: _resource_record_post_action 13:45:25 INFO - ##### 13:45:25 INFO - ##### Running download-and-extract step. 13:45:25 INFO - ##### 13:45:25 INFO - Running pre-action listener: _resource_record_pre_action 13:45:25 INFO - Running main action method: download_and_extract 13:45:25 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:45: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')]} 13:45:25 INFO - https://queue.taskcluster.net/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:45:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/test_packages.json 13:45:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/test_packages.json 13:45:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 13:45:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 13:45:26 INFO - Downloaded 1302 bytes. 13:45:26 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 13:45:26 INFO - Using the following test package requirements: 13:45:26 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:45:26 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:45:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:45:26 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:45:26 INFO - u'jsshell-linux-x86_64.zip'], 13:45:26 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:45:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:45:26 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:45:26 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:45:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:45:26 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:45:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:45:26 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:45:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:45:26 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:45:26 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:45:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:45:26 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:26 INFO - https://queue.taskcluster.net/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:45:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:45:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:45:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:45:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:45:29 INFO - Downloaded 22445073 bytes. 13:45:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 13:45:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:45:29 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:45:30 INFO - Return code: 0 13:45:30 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:30 INFO - https://queue.taskcluster.net/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:45:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:45:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:45:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:45:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:45:44 INFO - Downloaded 22445073 bytes. 13:45:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 13:45:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:45:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:45:45 INFO - Return code: 0 13:45: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')]} 13:45:45 INFO - https://queue.taskcluster.net/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:45:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:45:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:45:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:45:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:45:46 INFO - Downloaded 11131693 bytes. 13:45:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 13:45:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:45:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 13:45:46 INFO - Return code: 0 13:45: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')]} 13:45:46 INFO - https://queue.taskcluster.net/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:45:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:45:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:45:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:45:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:45:47 INFO - Downloaded 57137774 bytes. 13:45:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:45:47 INFO - mkdir: /builds/slave/test-pgo/properties 13:45:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:45:47 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:45:47 INFO - Contents: 13:45:47 INFO - build_url:https://queue.taskcluster.net/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:45:47 INFO - Running post-action listener: _resource_record_post_action 13:45:47 INFO - Running post-action listener: set_extra_try_arguments 13:45:47 INFO - ##### 13:45:47 INFO - ##### Running populate-webroot step. 13:45:47 INFO - ##### 13:45:47 INFO - Running pre-action listener: _resource_record_pre_action 13:45:47 INFO - Running main action method: populate_webroot 13:45:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:45:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:45:47 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 13:45:47 INFO - '../fennec_ids.txt'], 13:45:47 INFO - 'tests': ['tcheck2']}, 13:45:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:45:47 INFO - '--tppagecycles', 13:45:47 INFO - '7'], 13:45:47 INFO - 'tests': ['tsvgm']}}, 13:45:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:45:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:45:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:45:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:45:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:45:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:45:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:45:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:47 INFO - 'talos_options': ['--e10s'], 13:45:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:45:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:47 INFO - 'tests': ['damp', 'tps']}, 13:45:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:47 INFO - 'talos_options': ['--e10s'], 13:45:47 INFO - 'tests': ['damp', 'tps']}, 13:45:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:45:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:45:47 INFO - 'other': {'tests': ['a11yr', 13:45:47 INFO - 'ts_paint', 13:45:47 INFO - 'tpaint', 13:45:47 INFO - 'sessionrestore', 13:45:47 INFO - 'sessionrestore_no_auto_restore']}, 13:45:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:45:47 INFO - 'tests': ['a11yr', 13:45:47 INFO - 'ts_paint', 13:45:47 INFO - 'tpaint', 13:45:47 INFO - 'sessionrestore', 13:45:47 INFO - 'sessionrestore_no_auto_restore']}, 13:45:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:45:47 INFO - 'tests': ['a11yr', 13:45:47 INFO - 'ts_paint', 13:45:47 INFO - 'tpaint', 13:45:47 INFO - 'sessionrestore', 13:45:47 INFO - 'sessionrestore_no_auto_restore']}, 13:45:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:45:47 INFO - 'tests': ['a11yr', 13:45:47 INFO - 'ts_paint', 13:45:47 INFO - 'tpaint', 13:45:47 INFO - 'sessionrestore', 13:45:47 INFO - 'sessionrestore_no_auto_restore']}, 13:45:47 INFO - 'other_l64': {'tests': ['a11yr', 13:45:47 INFO - 'ts_paint', 13:45:47 INFO - 'tpaint', 13:45:47 INFO - 'sessionrestore', 13:45:47 INFO - 'sessionrestore_no_auto_restore']}, 13:45:47 INFO - 'other_nol64': {'tests': ['a11yr', 13:45:47 INFO - 'ts_paint', 13:45:47 INFO - 'tpaint', 13:45:47 INFO - 'sessionrestore', 13:45:47 INFO - 'sessionrestore_no_auto_restore']}, 13:45:47 INFO - 'svgr': {'tests': ['tsvgx', 13:45:47 INFO - 'tsvgr_opacity', 13:45:47 INFO - 'tart', 13:45:47 INFO - 'tscrollx', 13:45:47 INFO - 'cart']}, 13:45:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:45:47 INFO - 'tests': ['tsvgx', 13:45:47 INFO - 'tsvgr_opacity', 13:45:47 INFO - 'tart', 13:45:47 INFO - 'tscrollx', 13:45:47 INFO - 'cart']}, 13:45:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:47 INFO - 'tests': ['tp5o']}, 13:45:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:47 INFO - 'talos_options': ['--e10s'], 13:45:47 INFO - 'tests': ['tp5o']}, 13:45:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:47 INFO - 'talos_options': ['--xperf_path', 13:45:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:45:47 INFO - 'tests': ['tp5n']}, 13:45:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:47 INFO - 'talos_options': ['--e10s', 13:45:47 INFO - '--xperf_path', 13:45:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:45:47 INFO - 'tests': ['tp5n']}}, 13:45:47 INFO - 'talos.zip': {'path': '', 13:45:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:45:47 INFO - Running post-action listener: _resource_record_post_action 13:45:47 INFO - ##### 13:45:47 INFO - ##### Running create-virtualenv step. 13:45:47 INFO - ##### 13:45:47 INFO - Running pre-action listener: _resource_record_pre_action 13:45:47 INFO - Running main action method: create_virtualenv 13:45:47 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:45:47 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 13:45:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:45:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:45:47 INFO - Using real prefix '/usr' 13:45:47 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:45:48 INFO - Installing distribute.............................................................................................................................................................................................done. 13:45:51 INFO - Installing pip.................done. 13:45:51 INFO - Return code: 0 13:45:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:45:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:51 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 0x7f2cca12ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cec3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d758c0>, '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 0x1d22420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d228b0>, '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': 'ccb4611811c763f2fad71465000001de-1447450787.366734-23142978', '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 13:45:51 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 13:45:51 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 13:45:51 INFO - Using env: {'DISPLAY': ':0', 13:45:51 INFO - 'HOME': '/home/cltbld', 13:45:51 INFO - 'LANG': 'en_US.UTF-8', 13:45:51 INFO - 'LANGUAGE': 'en_US:en', 13:45:51 INFO - 'LOGNAME': 'cltbld', 13:45:51 INFO - 'MAIL': '/var/mail/cltbld', 13:45:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:51 INFO - 'MOZ_NO_REMOTE': '1', 13:45:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:51 INFO - 'NO_EM_RESTART': '1', 13:45:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:45:51 INFO - 'PWD': '/builds/slave/test-pgo', 13:45:51 INFO - 'SHELL': '/bin/bash', 13:45:51 INFO - 'SHLVL': '1', 13:45:51 INFO - 'TERM': 'linux', 13:45:51 INFO - 'TMOUT': '86400', 13:45:51 INFO - 'USER': 'cltbld', 13:45:51 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1447450787.366734-23142978', 13:45:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:51 INFO - '_': '/tools/buildbot/bin/python'} 13:45:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:51 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 13:45:51 INFO - Cleaning up... 13:45:51 INFO - Return code: 0 13:45:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:45:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:51 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 0x7f2cca12ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cec3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d758c0>, '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 0x1d22420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d228b0>, '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': 'ccb4611811c763f2fad71465000001de-1447450787.366734-23142978', '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 13:45:51 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 13:45:51 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 13:45:51 INFO - Using env: {'DISPLAY': ':0', 13:45:51 INFO - 'HOME': '/home/cltbld', 13:45:51 INFO - 'LANG': 'en_US.UTF-8', 13:45:51 INFO - 'LANGUAGE': 'en_US:en', 13:45:51 INFO - 'LOGNAME': 'cltbld', 13:45:51 INFO - 'MAIL': '/var/mail/cltbld', 13:45:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:51 INFO - 'MOZ_NO_REMOTE': '1', 13:45:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:51 INFO - 'NO_EM_RESTART': '1', 13:45:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:45:51 INFO - 'PWD': '/builds/slave/test-pgo', 13:45:51 INFO - 'SHELL': '/bin/bash', 13:45:51 INFO - 'SHLVL': '1', 13:45:51 INFO - 'TERM': 'linux', 13:45:51 INFO - 'TMOUT': '86400', 13:45:51 INFO - 'USER': 'cltbld', 13:45:51 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1447450787.366734-23142978', 13:45:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:51 INFO - '_': '/tools/buildbot/bin/python'} 13:45:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:51 INFO - Downloading/unpacking psutil>=0.7.1 13:45:51 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 13:45:51 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 13:45:51 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 13:45:51 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 13:45:51 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 13:45:51 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 13:45:53 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 13:45:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:45:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:45:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:45:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:45:54 INFO - Installing collected packages: psutil 13:45:54 INFO - Running setup.py install for psutil 13:45:54 INFO - building 'psutil._psutil_linux' extension 13:45:54 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 13:45:54 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 13:45:54 INFO - building 'psutil._psutil_posix' extension 13:45:54 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 13:45:54 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 13:45:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:45:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:45:55 INFO - Successfully installed psutil 13:45:55 INFO - Cleaning up... 13:45:57 INFO - Return code: 0 13:45:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:45:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:57 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 0x7f2cca12ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cec3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d758c0>, '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 0x1d22420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d228b0>, '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': 'ccb4611811c763f2fad71465000001de-1447450787.366734-23142978', '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 13:45:57 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 13:45:57 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 13:45:57 INFO - Using env: {'DISPLAY': ':0', 13:45:57 INFO - 'HOME': '/home/cltbld', 13:45:57 INFO - 'LANG': 'en_US.UTF-8', 13:45:57 INFO - 'LANGUAGE': 'en_US:en', 13:45:57 INFO - 'LOGNAME': 'cltbld', 13:45:57 INFO - 'MAIL': '/var/mail/cltbld', 13:45:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:57 INFO - 'MOZ_NO_REMOTE': '1', 13:45:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:57 INFO - 'NO_EM_RESTART': '1', 13:45:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:45:57 INFO - 'PWD': '/builds/slave/test-pgo', 13:45:57 INFO - 'SHELL': '/bin/bash', 13:45:57 INFO - 'SHLVL': '1', 13:45:57 INFO - 'TERM': 'linux', 13:45:57 INFO - 'TMOUT': '86400', 13:45:57 INFO - 'USER': 'cltbld', 13:45:57 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1447450787.366734-23142978', 13:45:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:57 INFO - '_': '/tools/buildbot/bin/python'} 13:45:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:45:58 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 13:45:58 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 13:45:58 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 13:45:58 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 13:45:58 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 13:45:58 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 13:45:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:45:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:45:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:45:59 INFO - Installing collected packages: mozsystemmonitor 13:45:59 INFO - Running setup.py install for mozsystemmonitor 13:45:59 INFO - Successfully installed mozsystemmonitor 13:45:59 INFO - Cleaning up... 13:45:59 INFO - Return code: 0 13:45:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:59 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 0x7f2cca12ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cec3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d758c0>, '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 0x1d22420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d228b0>, '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': 'ccb4611811c763f2fad71465000001de-1447450787.366734-23142978', '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 13:45:59 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 13:45:59 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 13:45:59 INFO - Using env: {'DISPLAY': ':0', 13:45:59 INFO - 'HOME': '/home/cltbld', 13:45:59 INFO - 'LANG': 'en_US.UTF-8', 13:45:59 INFO - 'LANGUAGE': 'en_US:en', 13:45:59 INFO - 'LOGNAME': 'cltbld', 13:45:59 INFO - 'MAIL': '/var/mail/cltbld', 13:45:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:59 INFO - 'MOZ_NO_REMOTE': '1', 13:45:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:59 INFO - 'NO_EM_RESTART': '1', 13:45:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:45:59 INFO - 'PWD': '/builds/slave/test-pgo', 13:45:59 INFO - 'SHELL': '/bin/bash', 13:45:59 INFO - 'SHLVL': '1', 13:45:59 INFO - 'TERM': 'linux', 13:45:59 INFO - 'TMOUT': '86400', 13:45:59 INFO - 'USER': 'cltbld', 13:45:59 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1447450787.366734-23142978', 13:45:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:59 INFO - '_': '/tools/buildbot/bin/python'} 13:46:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:46:00 INFO - Downloading/unpacking blobuploader==1.2.4 13:46:00 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 13:46:00 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 13:46:00 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 13:46:00 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 13:46:00 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 13:46:00 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 13:46:01 INFO - Downloading blobuploader-1.2.4.tar.gz 13:46:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:46:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:46:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:46:01 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 13:46:01 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 13:46:01 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 13:46:01 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 13:46:01 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 13:46:01 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 13:46:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:46:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:46:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:46:02 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 13:46:02 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 13:46:02 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 13:46:02 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 13:46:02 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 13:46:02 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 13:46:02 INFO - Downloading docopt-0.6.1.tar.gz 13:46:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:46:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:46:02 INFO - Installing collected packages: blobuploader, requests, docopt 13:46:02 INFO - Running setup.py install for blobuploader 13:46:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:46:02 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:46:02 INFO - Running setup.py install for requests 13:46:02 INFO - Running setup.py install for docopt 13:46:03 INFO - Successfully installed blobuploader requests docopt 13:46:03 INFO - Cleaning up... 13:46:03 INFO - Return code: 0 13:46:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:46:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:46:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:46:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:03 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 0x7f2cca12ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cec3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d758c0>, '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 0x1d22420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d228b0>, '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': 'ccb4611811c763f2fad71465000001de-1447450787.366734-23142978', '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 13:46:03 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 13:46:03 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 13:46:03 INFO - Using env: {'DISPLAY': ':0', 13:46:03 INFO - 'HOME': '/home/cltbld', 13:46:03 INFO - 'LANG': 'en_US.UTF-8', 13:46:03 INFO - 'LANGUAGE': 'en_US:en', 13:46:03 INFO - 'LOGNAME': 'cltbld', 13:46:03 INFO - 'MAIL': '/var/mail/cltbld', 13:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:03 INFO - 'MOZ_NO_REMOTE': '1', 13:46:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:03 INFO - 'NO_EM_RESTART': '1', 13:46:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:46:03 INFO - 'PWD': '/builds/slave/test-pgo', 13:46:03 INFO - 'SHELL': '/bin/bash', 13:46:03 INFO - 'SHLVL': '1', 13:46:03 INFO - 'TERM': 'linux', 13:46:03 INFO - 'TMOUT': '86400', 13:46:03 INFO - 'USER': 'cltbld', 13:46:03 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1447450787.366734-23142978', 13:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:03 INFO - '_': '/tools/buildbot/bin/python'} 13:46:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:46:03 INFO - Running setup.py (path:/tmp/pip-jR5G7X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:46:03 INFO - Running setup.py (path:/tmp/pip-gTvy0G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:46:03 INFO - Running setup.py (path:/tmp/pip-tOiLLv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:46:03 INFO - Running setup.py (path:/tmp/pip-cwpdaC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:46:03 INFO - Running setup.py (path:/tmp/pip-nF6DZO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:46:03 INFO - Running setup.py (path:/tmp/pip-qaQQpE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:46:03 INFO - Running setup.py (path:/tmp/pip-2j5N1_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:46:03 INFO - Running setup.py (path:/tmp/pip-qNq72o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:46:03 INFO - Running setup.py (path:/tmp/pip-QyiNJT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:46:03 INFO - Running setup.py (path:/tmp/pip-48GDO5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:46:04 INFO - Running setup.py (path:/tmp/pip-0V4TKS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:46:04 INFO - Running setup.py (path:/tmp/pip-q9BkUw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:46:04 INFO - Running setup.py (path:/tmp/pip-wC1wTb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:46:04 INFO - Running setup.py (path:/tmp/pip-RtDyny-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:46:04 INFO - Running setup.py (path:/tmp/pip-8zrV_e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:46:04 INFO - Running setup.py (path:/tmp/pip-FYyY8I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:46:04 INFO - Running setup.py (path:/tmp/pip-gkSHY_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:46:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:46:04 INFO - Running setup.py install for manifestparser 13:46:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:46:04 INFO - Running setup.py install for mozcrash 13:46:04 INFO - Running setup.py install for mozdebug 13:46:04 INFO - Running setup.py install for mozdevice 13:46:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:46:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:46:05 INFO - Running setup.py install for mozfile 13:46:05 INFO - Running setup.py install for mozhttpd 13:46:05 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:46:05 INFO - Running setup.py install for mozinfo 13:46:05 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:46:05 INFO - Running setup.py install for mozInstall 13:46:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:46:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:46:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:46:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:46:05 INFO - Running setup.py install for mozleak 13:46:05 INFO - Running setup.py install for mozlog 13:46:05 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:46:05 INFO - Running setup.py install for moznetwork 13:46:05 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:46:05 INFO - Running setup.py install for mozprocess 13:46:05 INFO - Running setup.py install for mozprofile 13:46:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:46:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:46:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:46:05 INFO - Running setup.py install for mozrunner 13:46:06 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:46:06 INFO - Running setup.py install for mozscreenshot 13:46:06 INFO - Running setup.py install for moztest 13:46:06 INFO - Running setup.py install for mozversion 13:46:06 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:46:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:46:06 INFO - Cleaning up... 13:46:06 INFO - Return code: 0 13:46:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:46:06 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')]} 13:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:46:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:06 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')]} 13:46:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:46:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:06 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 0x7f2cca12ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cec3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d758c0>, '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 0x1d22420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d228b0>, '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': 'ccb4611811c763f2fad71465000001de-1447450787.366734-23142978', '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 13:46:06 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 13:46:06 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 13:46:06 INFO - Using env: {'DISPLAY': ':0', 13:46:06 INFO - 'HOME': '/home/cltbld', 13:46:06 INFO - 'LANG': 'en_US.UTF-8', 13:46:06 INFO - 'LANGUAGE': 'en_US:en', 13:46:06 INFO - 'LOGNAME': 'cltbld', 13:46:06 INFO - 'MAIL': '/var/mail/cltbld', 13:46:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:06 INFO - 'MOZ_NO_REMOTE': '1', 13:46:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:06 INFO - 'NO_EM_RESTART': '1', 13:46:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:46:06 INFO - 'PWD': '/builds/slave/test-pgo', 13:46:06 INFO - 'SHELL': '/bin/bash', 13:46:06 INFO - 'SHLVL': '1', 13:46:06 INFO - 'TERM': 'linux', 13:46:06 INFO - 'TMOUT': '86400', 13:46:06 INFO - 'USER': 'cltbld', 13:46:06 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1447450787.366734-23142978', 13:46:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:06 INFO - '_': '/tools/buildbot/bin/python'} 13:46:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:46:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:46:06 INFO - Running setup.py (path:/tmp/pip-kXgg5V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:46:06 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)) 13:46:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:46:06 INFO - Running setup.py (path:/tmp/pip-AuTJyu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:46:06 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)) 13:46:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:46:06 INFO - Running setup.py (path:/tmp/pip-MRVfYw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:46:06 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)) 13:46:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:46:06 INFO - Running setup.py (path:/tmp/pip-Kvp9zo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:46:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:46:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:46:06 INFO - Running setup.py (path:/tmp/pip-HXrrOz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:46:06 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)) 13:46:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:46:06 INFO - Running setup.py (path:/tmp/pip-GNCmmN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:46:07 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)) 13:46:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:46:07 INFO - Running setup.py (path:/tmp/pip-vvaaek-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:46:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 13:46:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:46:07 INFO - Running setup.py (path:/tmp/pip-ZYpA1T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:46:07 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)) 13:46:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:46:07 INFO - Running setup.py (path:/tmp/pip-z5TWV3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:46:07 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)) 13:46:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:46:07 INFO - Running setup.py (path:/tmp/pip-R7vZTy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:46:07 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)) 13:46:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:46:07 INFO - Running setup.py (path:/tmp/pip-FRaEJn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:46:07 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)) 13:46:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:46:07 INFO - Running setup.py (path:/tmp/pip-ZOyL_8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:46:07 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)) 13:46:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:46:07 INFO - Running setup.py (path:/tmp/pip-yqssAf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:46:07 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)) 13:46:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:46:07 INFO - Running setup.py (path:/tmp/pip-iIqAHB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:46:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 13:46:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:46:07 INFO - Running setup.py (path:/tmp/pip-3ABnS2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:46:07 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)) 13:46:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:46:07 INFO - Running setup.py (path:/tmp/pip-77HauN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:46:07 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)) 13:46:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:46:07 INFO - Running setup.py (path:/tmp/pip-hakCYK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:46:07 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)) 13:46:07 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)) 13:46:07 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)) 13:46:07 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)) 13:46:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:46:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:46:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:46:07 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 13:46:07 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 13:46:07 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 13:46:07 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 13:46:07 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 13:46:07 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 13:46:09 INFO - Downloading blessings-1.5.1.tar.gz 13:46:09 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 13:46:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:46:09 INFO - Installing collected packages: blessings 13:46:09 INFO - Running setup.py install for blessings 13:46:09 INFO - Successfully installed blessings 13:46:09 INFO - Cleaning up... 13:46:09 INFO - Return code: 0 13:46:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:46:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:46:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:46:09 INFO - Reading from file tmpfile_stdout 13:46:09 INFO - Current package versions: 13:46:09 INFO - argparse == 1.2.1 13:46:09 INFO - blessings == 1.5.1 13:46:09 INFO - blobuploader == 1.2.4 13:46:09 INFO - docopt == 0.6.1 13:46:09 INFO - manifestparser == 1.1 13:46:09 INFO - mozInstall == 1.12 13:46:09 INFO - mozcrash == 0.16 13:46:09 INFO - mozdebug == 0.1 13:46:09 INFO - mozdevice == 0.47 13:46:09 INFO - mozfile == 1.2 13:46:09 INFO - mozhttpd == 0.7 13:46:09 INFO - mozinfo == 0.9 13:46:09 INFO - mozleak == 0.1 13:46:09 INFO - mozlog == 3.0 13:46:09 INFO - moznetwork == 0.27 13:46:09 INFO - mozprocess == 0.22 13:46:09 INFO - mozprofile == 0.27 13:46:09 INFO - mozrunner == 6.11 13:46:09 INFO - mozscreenshot == 0.1 13:46:09 INFO - mozsystemmonitor == 0.0 13:46:09 INFO - moztest == 0.7 13:46:09 INFO - mozversion == 1.4 13:46:09 INFO - psutil == 3.1.1 13:46:09 INFO - requests == 1.2.3 13:46:09 INFO - wsgiref == 0.1.2 13:46:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:46:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:46:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:46:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:46:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f2cca12ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cec3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d758c0>, '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 0x1d22420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d228b0>, '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': 'ccb4611811c763f2fad71465000001de-1447450787.366734-23142978', '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 13:46:09 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 13:46:09 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 13:46:09 INFO - Using env: {'DISPLAY': ':0', 13:46:09 INFO - 'HOME': '/home/cltbld', 13:46:09 INFO - 'LANG': 'en_US.UTF-8', 13:46:09 INFO - 'LANGUAGE': 'en_US:en', 13:46:09 INFO - 'LOGNAME': 'cltbld', 13:46:09 INFO - 'MAIL': '/var/mail/cltbld', 13:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:09 INFO - 'MOZ_NO_REMOTE': '1', 13:46:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:09 INFO - 'NO_EM_RESTART': '1', 13:46:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:46:09 INFO - 'PWD': '/builds/slave/test-pgo', 13:46:09 INFO - 'SHELL': '/bin/bash', 13:46:09 INFO - 'SHLVL': '1', 13:46:09 INFO - 'TERM': 'linux', 13:46:09 INFO - 'TMOUT': '86400', 13:46:09 INFO - 'USER': 'cltbld', 13:46:09 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1447450787.366734-23142978', 13:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:09 INFO - '_': '/tools/buildbot/bin/python'} 13:46:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:46:10 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)) 13:46:10 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)) 13:46:10 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)) 13:46:10 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)) 13:46:10 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)) 13:46:10 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)) 13:46:10 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)) 13:46:10 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)) 13:46:10 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)) 13:46:10 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)) 13:46:10 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)) 13:46:10 INFO - Cleaning up... 13:46:10 INFO - Return code: 0 13:46:10 INFO - Running post-action listener: _resource_record_post_action 13:46:10 INFO - Running post-action listener: _start_resource_monitoring 13:46:10 INFO - Starting resource monitoring. 13:46:10 INFO - ##### 13:46:10 INFO - ##### Running install step. 13:46:10 INFO - ##### 13:46:10 INFO - Running pre-action listener: _resource_record_pre_action 13:46:10 INFO - Running main action method: install 13:46:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:46:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:46:10 INFO - Reading from file tmpfile_stdout 13:46:10 INFO - Detecting whether we're running mozinstall >=1.0... 13:46:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:46:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:46:10 INFO - Reading from file tmpfile_stdout 13:46:10 INFO - Output received: 13:46:10 INFO - Usage: mozinstall [options] installer 13:46:10 INFO - Options: 13:46:10 INFO - -h, --help show this help message and exit 13:46:10 INFO - -d DEST, --destination=DEST 13:46:10 INFO - Directory to install application into. [default: 13:46:10 INFO - "/builds/slave/test-pgo"] 13:46:10 INFO - --app=APP Application being installed. [default: firefox] 13:46:10 INFO - mkdir: /builds/slave/test-pgo/build/application 13:46:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 13:46:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 13:46:24 INFO - Reading from file tmpfile_stdout 13:46:24 INFO - Output received: 13:46:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:46:24 INFO - Running post-action listener: _resource_record_post_action 13:46:24 INFO - ##### 13:46:24 INFO - ##### Running run-tests step. 13:46:24 INFO - ##### 13:46:24 INFO - Running pre-action listener: _resource_record_pre_action 13:46:24 INFO - Running main action method: run_tests 13:46:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:46:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:46:24 INFO - Python 2.7.3 13:46:24 INFO - Return code: 0 13:46:24 INFO - grabbing minidump binary from tooltool 13:46:24 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')]} 13:46:24 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 0x1d758c0>, '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 0x1d22420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d228b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:46:24 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 13:46:24 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 13:46:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:46:24 INFO - Return code: 0 13:46:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:46:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:46:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:46:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:46:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:46:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 13:46:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost 13:46:24 INFO - Using env: {'DISPLAY': ':0', 13:46:24 INFO - 'HOME': '/home/cltbld', 13:46:24 INFO - 'LANG': 'en_US.UTF-8', 13:46:24 INFO - 'LANGUAGE': 'en_US:en', 13:46:24 INFO - 'LOGNAME': 'cltbld', 13:46:24 INFO - 'MAIL': '/var/mail/cltbld', 13:46:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:46:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:46:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:24 INFO - 'MOZ_NO_REMOTE': '1', 13:46:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:46:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:24 INFO - 'NO_EM_RESTART': '1', 13:46:24 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:46:24 INFO - 'PWD': '/builds/slave/test-pgo', 13:46:24 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:46:24 INFO - 'SHELL': '/bin/bash', 13:46:24 INFO - 'SHLVL': '1', 13:46:24 INFO - 'TERM': 'linux', 13:46:24 INFO - 'TMOUT': '86400', 13:46:24 INFO - 'USER': 'cltbld', 13:46:24 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1447450787.366734-23142978', 13:46:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:24 INFO - '_': '/tools/buildbot/bin/python'} 13:46:24 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost'] with output_timeout 3600 13:46:25 INFO - mozversion INFO | application_buildid: 20151113113033 13:46:25 INFO - mozversion INFO | application_changeset: 8f4312027a498f6c89e23ab42fc3d161b2df66f0 13:46:25 INFO - mozversion INFO | application_display_name: Nightly 13:46:25 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:46:25 INFO - mozversion INFO | application_name: Firefox 13:46:25 INFO - mozversion INFO | application_remotingname: firefox 13:46:25 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 13:46:25 INFO - mozversion INFO | application_vendor: Mozilla 13:46:25 INFO - mozversion INFO | application_version: 45.0a1 13:46:25 INFO - mozversion INFO | platform_buildid: 20151113113033 13:46:25 INFO - mozversion INFO | platform_changeset: 8f4312027a498f6c89e23ab42fc3d161b2df66f0 13:46:25 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 13:46:25 INFO - mozversion INFO | platform_version: 45.0a1 13:46:25 INFO - 2015-11-13 13:46:25,075 DEBUG : using testdate: 1447451185 13:46:25 INFO - 2015-11-13 13:46:25,075 DEBUG : actual date: 1447451185 13:46:25 INFO - 2015-11-13 13:46:25,083 INFO : starting webserver on 'localhost:48827' 13:46:25 INFO - 2015-11-13 13:46:25,084 INFO : Starting test suite talos-linux64-ix-021 13:46:25 INFO - 2015-11-13 13:46:25,085 INFO : Starting test dromaeo_css 13:46:25 INFO - 2015-11-13 13:46:25,085 DEBUG : operating with platform_type : linux_ 13:46:25 INFO - 2015-11-13 13:46:25,085 INFO : Initialising browser for dromaeo_css test... 13:46:25 INFO - 2015-11-13 13:46:25,099 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0pAfpt/profile http://localhost:48827/getInfo.html 13:46:30 INFO - 2015-11-13 13:46:30,077 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:46:30 INFO - 2015-11-13 13:46:30,077 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:46:30 INFO - 2015-11-13 13:46:30,077 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:46:30 INFO - 2015-11-13 13:46:30,077 DEBUG : BROWSER_OUTPUT: __metrics 13:46:30 INFO - 2015-11-13 13:46:30,178 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:46:32 INFO - 2015-11-13 13:46:32,469 INFO : Browser initialized. 13:46:32 INFO - 2015-11-13 13:46:32,469 INFO : Running cycle 1/1 for dromaeo_css test... 13:46:32 INFO - 2015-11-13 13:46:32,469 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0pAfpt/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:46:44 INFO - 2015-11-13 13:46:44,217 DEBUG : BROWSER_OUTPUT: RSS: Main: 141295616 13:46:44 INFO - 2015-11-13 13:46:44,217 DEBUG : BROWSER_OUTPUT: 13:47:34 INFO - 2015-11-13 13:47:34,934 DEBUG : BROWSER_OUTPUT: 1447451254933 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] 13:49:44 INFO - 2015-11-13 13:49:44,995 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48827/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48827/tests/dromaeo/cssquery-ext.html) 13:49:46 INFO - 2015-11-13 13:49:46,099 DEBUG : BROWSER_OUTPUT: RSS: Main: 236765184 13:49:46 INFO - 2015-11-13 13:49:46,100 DEBUG : BROWSER_OUTPUT: 13:52:48 INFO - 2015-11-13 13:52:48,416 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48827/tests/dromaeo/cssquery-ext.html (next: http://localhost:48827/tests/dromaeo/cssquery-jquery.html) 13:52:48 INFO - 2015-11-13 13:52:48,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 220237824 13:52:48 INFO - 2015-11-13 13:52:48,987 DEBUG : BROWSER_OUTPUT: 13:55:50 INFO - 2015-11-13 13:55:50,872 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48827/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48827/tests/dromaeo/cssquery-mootools.html) 13:55:51 INFO - 2015-11-13 13:55:51,454 DEBUG : BROWSER_OUTPUT: RSS: Main: 210214912 13:55:51 INFO - 2015-11-13 13:55:51,454 DEBUG : BROWSER_OUTPUT: 13:58:53 INFO - 2015-11-13 13:58:53,301 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48827/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48827/tests/dromaeo/cssquery-prototype.html) 13:58:53 INFO - 2015-11-13 13:58:53,882 DEBUG : BROWSER_OUTPUT: RSS: Main: 201146368 13:58:53 INFO - 2015-11-13 13:58:53,883 DEBUG : BROWSER_OUTPUT: 14:01:56 INFO - 2015-11-13 14:01:56,295 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48827/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48827/tests/dromaeo/cssquery-yui.html) 14:01:56 INFO - 2015-11-13 14:01:56,876 DEBUG : BROWSER_OUTPUT: RSS: Main: 204767232 14:01:56 INFO - 2015-11-13 14:01:56,876 DEBUG : BROWSER_OUTPUT: 14:04:59 INFO - 2015-11-13 14:04:59,322 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48827/tests/dromaeo/cssquery-yui.html (next: http://localhost:48827/tests/dromaeo/cssquery-dojo.html) 14:04:59 INFO - 2015-11-13 14:04:59,572 DEBUG : BROWSER_OUTPUT: RSS: Main: 259715072 14:04:59 INFO - 2015-11-13 14:04:59,572 DEBUG : BROWSER_OUTPUT: 14:04:59 INFO - 2015-11-13 14:04:59,572 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:04:59 INFO - 2015-11-13 14:04:59,572 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:04:59 INFO - 2015-11-13 14:04:59,572 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:04:59 INFO - 2015-11-13 14:04:59,573 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:04:59 INFO - 2015-11-13 14:04:59,573 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3254.6419893811685;3294.159989202753;3329.350776598564;3337.399268131737;3356.2448449098947;5317.627766056377;5453.618246722731;5470.91793623096;5547.30658667666;5562.110062390018;5420.1327787554;5544.417836127209;5557.083081291582;5598.188262701906;5610.4670056344685;5024.849254522361;5057.165567681328;5102.489751024905;5143.15138002231;5175.146100893348;4892.486288939664;5118.4113826909825;5134.537891589756;5177.767000484969;5207.557357624588;4923.65534412593;5037.5718063964605;5059.038782631288;5072.442031376546;5086.872828179288;5056.292119103328;5057.039162559102;5070.264811602334;5086.440491545927;5112.36095488064;4955.578775804061;5055.5702765265;5064.088464076464;5065.974670126626;5072.594192464631;5261.76322065508;5338.039152952467;5404.6486978346675;5410.675359478444;5423.810166644188;6078.209832721762;6096.512279017668;6099;6101.511879049665;6106.4809491192855;5756.8848623027725;5911.467967882868;6083.148359229712;6084.421979911901;6089.3910608939195;5493.615446918718;5588.6646801192055;5593.272874526367;5600.747966341524;5618.494335509783;6140.785072522441;6142.938570614326;6144.38556144382;6148.907766383508;6158.630482170995;5760.07838745807;5840.211571437886;5936.495397891142;5950.306550500144;5982.012967860342;6092.791487165245;6101.482626480511;6102.786919474606;6104.489471593237;6106.855039299537;6065.484433823086;6067.211262535842;6072.301685306158;6090.299615544181;6099.963006288942;5833.912491312633;5902.05567109269;6024.548158888101;6081.027035674271;6081.179040829431;4552.271636538138;4555.840545580889;4574.130915126116;4582.610478109332;4589.288660257599;4059.3707975263883;4064.634182923492;4074.103697186614;4081.387791831249;4102.938455923164;5469.863253418696;5514.476124768141;5560.7219639018695;5583.05088135018;5607.747651355618;5963.284405871236;6061;6071.908921366183;6086.665233412116;6088.786892458743;5440.183972404171;5650.74571644277;5660.29246344207;5675.971620141955;5677.489025987681;5106.897862042812;5194.506521880416;5237.031149237403;5242.239875218072;5276.604254680914;6346.2384513857705;6368.522360822864;6371.968140159455;6376.043593460925;6381.840453988594;5685.914711279252;5814.30228372598;6107.664078475549;6134.9079763804475;6139.26328840542;6110.358412366638;6205.844853878689;6208.472279856082;6208.81373558794;6212.192414986023;5902.822915312548;5977.162213844849;5989.371116032754;5993.70031498432;6026.90959635597;5919.200907877554;6004.969975150097;6073.30157031947;6093.055576385667;6107.816765497042;5897.439743224387;5902.498287645598;5918.704064796829;5919.052951527735;5940.28716553999;5861.9413805861395;5905.675187864536;5911.113332999912;5914.763409463745;5917.112433135064;5594.13290939905;5692.800751973661;5772.826815195551;5789.247397838422;5904.439078287728;5983.431574000463;5995.940040599713;5999.610025348338;6050.062240352752;6051.546134039877;5837.532997360286;5855.912161317498;5858.648481091148;5868.383819699041;5869.501092407193 14:04:59 INFO - 2015-11-13 14:04:59,576 DEBUG : BROWSER_OUTPUT: |1;ext.html;555.2839964805943;583.9795607153749;590.2680675961806;594.2927915780219;594.8512871782054;38748.612513874854;39440.80279598602;39601;39615.405768913486;39623.60376396239;42372.364414533804;42805.14389712204;42956.140877182515;42967.57032429675;43089;7548.8112797179965;7696.615169241543;8577.099404562525;8780.824383512327;9901.851472227921;10048.94975525125;10177.694669159937;10200.438975856325;10205.03052210039;10207.438590877498;10230.744231394237;10358.844617330746;10375.792484150312;10386.27296089274;10386.428746418944;7828.569428681449;8051.838963220762;10053.296269261155;10246.846297305547;10286.228532860065;9785.168260697848;9859.30984831062;9913.058259465339;9919.206463482904;9919.702408927744;39129.60870391288;39578.60421395778;39601.60398396008;39606.405903911465;39703.404448933;3370.4438767603315;3472.774269672463;3567.5362202913457;3657.7929283336703;3787.4129509926006;30229.395412091853;30547.847260763778;30617.693823061705;30711.692883071108;30771.384572308427;3513.5959364672876;3589.3180295743723;3608.206194637202;3642.3807952648112;3695.61196074411;281691;282280;282631;283136;283939;55041;55776.72111639497;55885;57006.429935700944;57485;57608.423915761145;57625.42374576285;57802;58114.12828807571;58244.417555824744;14408.20754858493;14683.972121951574;14687.853121468863;14708.117512949044;14736.778948315783;10806.297590656583;10850.131989440984;10880.67357979262;10882.075023623082;10894.564217431373;18928.62142757165;19000.61998760017;19137.808621913882;19166.329178478685;19201.423957281302;7158.642067896584;7319.451041171933;7417.703291868264;7457.179710231871;7468.178500364956;925.1303774451993;979.8873129590188;1033.1682995188944;1057.5505410200633;1070.0690399352457;28605.14184574466;28903.132906012852;28917.855410723234;29228;29304.853475732485;989.3717489394287;998.336106489191;999.2405771613626;1099.0438318662814;1115.1803424482998;13515.86484135146;13641.75327069279;13726.313684315744;13858.307084645727;13870.237136957363;324270;328828;330631;331929;332163;46250.768746156056;46400.5359946403;46440.767796160806;46487.30269045967;46524.767376162905;1348.6426097084282;1352.1481466676128;1370.2600595678223;1370.9040367174402;1373.0937581196563;23186.420339491648;27925.301867453476;28429.147125586267;28821.855890720413;28952;47057.2941405886;48612.5138748608;48634;48663.513364865896;48761.2685809706;274159;275888;276936;276947;277385;28096;28462.57306140368;31168.844155779076;31235.219119522193;31940.68059319377;42150.15699685928;42398;42610;43096;43502.782486087366;35885;35997.82001089978;36100.81949590235;36983.815080924425;37156.62843371532;35837.283254334245;36025.81987090048;36424.63575364213;36627.816860915525;36637.63362366342;35909.204539772385;35916.4612530807;36074.09814754652;36334.8183259082;36353.636463635026;31636.841815790773;32588.185295367806;32597.511037333985;32701.509477358333;32882.34235315328;24802.131925382524;24968.500629986935;25030.37424064413;25118.623220651338;25348.74651253464 14:04:59 INFO - 2015-11-13 14:04:59,576 DEBUG : BROWSER_OUTPUT: |2;jquery.html;340.4059915447543;341.8154196733763;344.70183291452895;347.3608560249141;347.494395654323;14548.272586370666;14881.255937203123;16476.42332518362;16716.414925477595;17574.209160587787;14849.257537123154;14959.626009349771;15693.45072922448;15870.920645396756;15981.121038342886;5081.6696914700515;5313.760880760356;5329.786808527654;5333.173358129477;5343.332083489564;3990.8403663853555;4087.591240875918;5282.762275697583;5766.82699519013;5922.022866227089;5814.273215848019;5846.2107615472005;5847;5860.179574859523;5869.178315035899;5677.318721753375;5750.913736293917;5780.855478613026;5782.884342313172;5785.132230165466;4990.850274491771;4995.200767877122;5012.924806127911;5017.7491125443585;5022.096022715946;20604.454665899968;20689.27587534444;20986.370408887604;21098.683519747217;21262.893685531628;2035.297822251321;2064.917403303866;2116.883571403572;2154.1168121070286;2192;11818.881811181951;12022.038236941024;12064.638060858188;12137.939310303393;12191.146619736623;1815.7094864821697;1820.399268241477;1830.7253911913187;1866.9626607467774;1870.1397357215697;55558.72220638912;56150.71924640392;57280;60291.09563356553;61026.389736102516;6715.56348837324;6900.447964162855;6966.059581956472;7010.824729381806;7047.718091276394;8388.035375931846;8399.748007559661;8408.453450525696;8408.789780255542;8413.200745929127;5560.833175004756;5573.41479144692;5580.888382232414;5603.831885043455;5608.9439105609235;5743.684097374601;5744.138379243063;5758.2514273144225;5781.161731548902;5782.826515204551;3249.4638384666264;3255.283837555734;3270.05168501132;3278.3607196596436;3281.032095531824;1102.4653043274006;1105.4693747001484;1105.9612913548149;1107.2692023264767;1148.9253198542067;460.5026571303052;477.801712289403;478.93534372859216;485.66003797342;499.78009675742555;11415.42922853854;11553.422328883522;11772;11803;11874.1094417919;496.74417674897455;498.1804930888668;507.84510724229466;523.4660646140991;531.6464551073493;6345.841353966095;6546.639934803631;6564.179477565304;6621.834454138685;6817.659117044128;361136;361345;362961;365336;376941;76753;77117.61441192759;79008.60495697484;79400;80074.19925800667;514.3724655919772;528.9973550132224;532.292051571409;532.5819231903015;532.8934213157384;10633.468326583485;10737.194710396907;10796.40619765889;11059.72350691239;11103.222774405715;34843;34928.476072859434;35890.28219435649;35912.82043589765;36009.639903600626;43033;45889.54110458853;47618.761906191634;49153.75423123004;49340.01319973508;6725.327467253235;6765.526413151032;6831.419329357061;6833.794986150423;6840.794776156723;12516.937415312865;12716.872831271568;12772.042096842959;12837.229766214057;12930.159539629894;9220.170184683411;9608.855867162138;9765.316427849983;11013.229073965065;11132.55469781232;10470.319429237075;10697.358158510515;10823.837642435527;10850.29473084247;10871.130309575374;11187.10503159729;11219.551217951517;11423.85761423851;11468.94265528667;11596.362200079077;5690.487856092972;6780.288069752803;6893.517453778188;6907.551009184387;6939.82650433723;10947.781044379228;11097.667069987914;11282.492287846902;11284.266522676;11332.150088743541 14:04:59 INFO - 2015-11-13 14:04:59,580 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1324.496691257322;1656.7100757367461;1678.3789997700853;1703.3952946703928;1709.726443768997;6357.61854288743;6887.207971083327;7066.929330706691;7075.858482830353;7077.716891324348;7213.170485394181;7333.083364579427;7354.6322683865865;7357.595332256724;7377.631118444083;1908.5419499320203;1929.68160253558;2115.4499830044224;2125.904334304952;2154.892255387232;2218.92233771818;2223.4219103033247;2226.365485836537;2227.142550118208;2227.922022729205;2158.5251244726214;2213.1589995801573;2213.690083388327;2216.3018649125556;2218.67829164771;1881.6236752649525;1906.1136571494253;2104.9684254736267;2136.487243061654;2141.314779270634;2168.533765240481;2179.6730490426403;2202.9559408811892;2207.0509680837235;2235.429965358839;7428.480006399554;7490.138634057099;7493.550386976799;7502.399808015346;7503.024606801081;4421.093675796454;4500.752458614775;4537;4546.204414227497;4547.431571053618;2903.4483448144997;2948.3366242595457;2969.049904030711;2985.149232468758;3047.5733397324393;848.0586548930683;854.248261529856;870.8301881133182;946.9384490008127;1878.286251224526;10014.749631259205;10095.39427634337;10099.29304948654;10111.241656875764;10132.594696212143;3929.390944403622;4014.5985401460202;4064.7357921734992;4085.652719518874;4095.180963807191;8053.355731541463;8090.271875531231;8097.433179677484;8099.959500202579;8119;4428.6678499112695;4443.6667249955735;4467;4484.304932735431;4491.146682130385;4041.959580404217;4054.8175332109536;4080.9795951020055;4088.591140885947;4089.9795501022304;3281.622613399442;3308.1894935740415;3337.748344370861;3341.7159541438764;3342.9498557521656;1011.5094179323022;1018.6027449294781;1022.9232807539464;1034.110664828247;1034.5086084110137;1023.1201166996377;1031.9535620897077;1032.6540608895955;1157.242006485753;1309.8559158492558;6882.070920425778;6974.058502102152;6984.266652001466;6988.301169883072;7013.6142512161305;477.80887644941606;478.58124141376294;486.4454521845099;487.4954422173034;491.0841281010889;5521.641093328921;5579.6652200868075;5580.720963951786;5581.720913954286;5584.692841893653;8768.167024132697;8893.110688931056;9067.863982040275;9069;9165.450072995642;8946.239569636653;9068.909310906938;9107.544622768835;9156.221721153643;9171.44971301724;6888.965555172192;7017.859642807115;7076.504644674927;7127.358537731629;7134.892976605355;6731.562448440835;6789.966050169717;6805.421539169028;6810.5913645181445;6827.897581536182;7593.126790419173;7859.371250299848;7926.881096783438;7932.0878099017045;8025;7990.121086680577;8160.591970401575;8190.221928916743;8332.583370831555;8338.749837504885;6337.746490140527;6368.64972426521;6380.393862583047;6445.097686323825;6461.61230326182;7243.130824301117;7315.63421828917;7330.010448589373;7333.230010848784;7343.889841652486;6794.150731158606;6944.861102777815;6961.6519174042105;7020.719171233298;7036.577805331696;5742.799002034909;5769.96140694679;5819.185314055951;6646.268910419753;6716.992451132369;6802.217744959393;6846.281140480178;6850.554713943578;6851.212110607344;6855.314468553105;6068.453839154321;6136.2636483622255;6161.353057928853;6224.346443623354;6239.875202496016;6274.403931626488;6318.178636777373;6318.778842740482;6330.778422755181;6340.461060809883 14:04:59 INFO - 2015-11-13 14:04:59,580 DEBUG : BROWSER_OUTPUT: |4;prototype.html;323.6262117254571;325.3622899117731;325.9902202933912;328.3171004311033;333.2368875275619;6082.543809214305;6127.816165515031;6138.079288106786;6146.108814221935;6176.2279715035675;5999.760009599621;6028.69856507174;6033.426824451681;6044.818655440333;6045.486133678643;4600.7239565626005;4611.677182597203;4612.377329060568;4612.815487380501;4613.100445413146;4347.978260108695;4449.688521803475;4459.197344477992;4466.665000125004;4611.5619016193405;4429.712068715539;4433.024734558408;4438.800253988562;4439.378487011821;4446.844360447385;4275.828966841323;4356.128774245164;4443.644508439334;4446.3108218226225;4451.888702782424;3725.3108174987715;3732.925341493155;3733.290674771785;3737.495438115847;3815.389537673959;5688.947544704201;5691;5707.800226992035;5738.311402631669;5744.22452968848;5254.553362964152;5262.342207224097;5277.076511610491;5279.551238144724;5288.814891478818;5977;6095.664738439384;6305.905411418832;6366.745330186787;6439.903401448982;4231.767252801094;4232.153569286155;4233.068724880522;4239.0674051708575;4249.405083288342;6594.736210551572;6610.7355705771715;6677.298883617247;6682.097916781221;6693.799186024378;4406;4416.006398560298;4425;4426.44669416323;4431.82272709088;4377.715448495837;4423.225935461282;4443.977780111079;4451.933221001687;4462.308342206963;5233;5239.973800130975;5240.3973543042275;5247.580193584504;5248.6325957182635;6477.481801455872;6479.514036447285;6485.643289619116;6492.188476440445;6492.870142597121;1539.076554067573;1541.3295216580823;1542.2674229741008;1545.7526795712631;1547.1104115133844;1022.156720705421;1024.2778840917285;1028.3161697471248;1050;1051.9474026298653;6194.473469755031;6196.287426945869;6202.968985155136;6203.844903877439;6208.50331973441;6651.467882569383;6658.167729033871;6662.6668666566475;6671.166104236971;6679;6024.789132380346;6175;6199.5660303779205;6199.752009919553;6209.9068513972325;3507.5089487471773;3602.495650608917;3626.292872889814;3628.7822730636244;3630.146915474861;6797;6875.828104297332;6904.482163837632;6912.930870691329;7028.50800443964;6795.150606174228;6798.422134118557;6805.795826125224;6816.352446517573;6824.863502729918;6790.083338749305;6944.375006249563;6964.164300283897;6972.267911869282;6976.302369762983;6667.899981500184;6699.866002680016;6715.093462382712;6719.193696756421;6731.562448440835;6646.468282537482;6649.368310010541;6650.767223147167;6652.667366631552;6654.234763002317;6815.045893574805;6975.128108986377;6976.372126508639;6979.267176946348;6986.126734158231;4444.022315090675;4445.799939002817;4446.9777651111535;4448.088141930961;4450.087732014865;6671.432928200963;6682.2649508555;6682.431993280431;6691.330866913269;6692.899606505809;6371.776987805404;6506.837329066811;6508;6522.934770652233;6528.477721782151;6521.8695626088165;6523.706433210422;6526.216853977553;6526.988316810902;6530.118434011348;6411.102445657705;6413.7113829876835;6414.679266036586;6422.454091402096;6431.163948686641;6403.455706265019;6545.280019197789;6554.410103090554;6556.147700799056;6564.245111812203;6398.584092034003;6400.071989561395;6400.103985442135;6402.87194256103;6406.13517175194 14:04:59 INFO - 2015-11-13 14:04:59,584 DEBUG : BROWSER_OUTPUT: |5;yui.html;753.4688044928323;755.4070055006821;757.4394947738673;773.7910764093691;809.1706001348617;14088.788668169986;14196.148231106115;14232.288385580718;14263;14264;13408.854583266679;13505.122167059135;13507.459701611924;13534.864651353484;13546.796798048012;668.7559040950042;684.9452043836482;805.5126648377735;806.5322113174345;820.7660816667251;817.2930415190876;820.7742870710573;825.1995564302617;827.4166712467696;827.668932427031;864.7535452396069;868.9217970382664;871.0723079919896;871.172386233078;871.2246100970142;712.5831388637653;720.5352547606791;854.8632218844986;858.1118542308743;868.3183700794846;637.3117033603697;637.4963778614889;638.7445021991194;639.1243995725886;639.1371648274838;13464.259465729381;13538.120022198525;13547.661308467268;13555.390007449689;13593.796093058612;12107.213031152947;12260.570880019157;12269.815952760715;12507.874921250763;12939.611811645571;10025.799484010351;10521.105706014998;10564.577416903314;10679.572817087308;10725.678229653124;3655.5430571178604;3668.1196512836996;3676.8161591920566;3690.612485689018;3812.1803812180515;47668.28497572539;47717.52282477166;47878.28182577264;48211;49034.75482622635;9428.90571094294;9430.811383772287;9466.432014079039;9504.287178461644;9543.379680320757;18103.81896181021;18106.366277180234;18194.54513637143;18277.54306142357;18295.176717047765;7926.286634202949;8009.559474228973;8027;8079.5960201989665;8272.255497005179;4148;4163.042500224965;4305.892352691145;4335.761533115646;4354.499232588293;3132.98433507831;3141.1204862638497;3141.2618034761813;3141.340318533088;3149.165471150147;459.6644449551846;468.8780916961546;472.9810807567659;474.3146153807784;487.84145152825477;657.2901266632026;665.5574043261178;665.7836203233968;675.8310422394402;698.0541366448491;7719.382449404035;8420.957895210484;8606.741797746077;8717.433366831136;8900.46597204157;529.1929807044212;698.828786947191;709.9041629380071;710.2010238481708;716.7240612364277;3728.2729867676085;3864.9613503864603;3914.5106861642294;3930.744501607386;3960;51674.74162629163;52137;52171.47828521742;57577.13634295489;57604;46422.07155856932;46628.76685616618;47116.293255601195;47670.5232947673;50759.49240507548;45650.31524527201;45972.310415343796;46029.30956035662;46195.76902115468;47052.76473617678;8218.917810821815;8400.243978042006;8422.199891010345;8438.704645337384;8484.151584841713;34525.827370862986;35250.64749352474;35337.46993795044;35515.644843551236;36280.27439451249;41372.58627413688;43923.56076439195;44700.77649611731;44808;44863.32705009362;7986.880196796937;8013.559254241072;8196.795080123045;8341.45780524264;8385.245327920273;12233.449494772934;12326.137170397986;12543.686407839878;12676.049296303;12777.425015874122;10577.206709496972;10629.574817007233;10978.12175026012;11057;11478.540858365906;10604.787904241717;10801.24391292602;10843;10866.18503612248;11209.831852522382;7894;10498.737531561466;10987.725306867393;11036.779264414827;11196.720081998015;9494;9530.475823829756;9753.317267791186;9877.160441362565;10204.38773673582;9117.36178467501;9301.813963720553;9344.579493922654;9375.578098985425;9552.283578731483 14:04:59 INFO - 2015-11-13 14:04:59,584 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:04:59 INFO - 2015-11-13 14:04:59,584 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:04:59 INFO - 2015-11-13 14:04:59,584 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,837 14:04:59 INFO - 2015-11-13 14:04:59,584 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:04:59 INFO - 2015-11-13 14:04:59,585 DEBUG : BROWSER_OUTPUT: __startTimestamp1447452299569__endTimestamp 14:04:59 INFO - 2015-11-13 14:04:59,585 DEBUG : BROWSER_OUTPUT: 14:04:59 INFO - 2015-11-13 14:04:59,585 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:04:59 INFO - 2015-11-13 14:04:59,585 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:04:59 INFO - 2015-11-13 14:04:59,585 DEBUG : BROWSER_OUTPUT: 14:04:59 INFO - 2015-11-13 14:04:59,585 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5575.84 Median:5814.30 stddev:649.65 (11.2%) stddev-sans-first:625.60 14:04:59 INFO - 2015-11-13 14:04:59,585 DEBUG : BROWSER_OUTPUT: Values: 3254.6 3294.2 3329.4 3337.4 3356.2 5317.6 5453.6 5470.9 5547.3 5562.1 5420.1 5544.4 5557.1 5598.2 5610.5 5024.8 5057.2 5102.5 5143.2 5175.1 4892.5 5118.4 5134.5 5177.8 5207.6 4923.7 5037.6 5059.0 5072.4 5086.9 5056.3 5057.0 5070.3 5086.4 5112.4 4955.6 5055.6 5064.1 5066.0 5072.6 5261.8 5338.0 5404.6 5410.7 5423.8 6078.2 6096.5 6099.0 6101.5 6106.5 5756.9 5911.5 6083.1 6084.4 6089.4 5493.6 5588.7 5593.3 5600.7 5618.5 6140.8 6142.9 6144.4 6148.9 6158.6 5760.1 5840.2 5936.5 5950.3 5982.0 6092.8 6101.5 6102.8 6104.5 6106.9 6065.5 6067.2 6072.3 6090.3 6100.0 5833.9 5902.1 6024.5 6081.0 6081.2 4552.3 4555.8 4574.1 4582.6 4589.3 4059.4 4064.6 4074.1 4081.4 4102.9 5469.9 5514.5 5560.7 5583.1 5607.7 5963.3 6061.0 6071.9 6086.7 6088.8 5440.2 5650.7 5660.3 5676.0 5677.5 5106.9 5194.5 5237.0 5242.2 5276.6 6346.2 6368.5 6372.0 6376.0 6381.8 5685.9 5814.3 6107.7 6134.9 6139.3 6110.4 6205.8 6208.5 6208.8 6212.2 5902.8 5977.2 5989.4 5993.7 6026.9 5919.2 6005.0 6073.3 6093.1 6107.8 5897.4 5902.5 5918.7 5919.1 5940.3 5861.9 5905.7 5911.1 5914.8 5917.1 5594.1 5692.8 5772.8 5789.2 5904.4 5983.4 5995.9 5999.6 6050.1 6051.5 5837.5 5855.9 5858.6 5868.4 5869.5 14:04:59 INFO - 2015-11-13 14:04:59,585 DEBUG : BROWSER_OUTPUT: 14:04:59 INFO - 2015-11-13 14:04:59,586 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46406.03 Median:3540.57 stddev:77614.62 (2192.2%) stddev-sans-first:77756.00 14:04:59 INFO - 2015-11-13 14:04:59,586 DEBUG : BROWSER_OUTPUT: Values: 555.3 584.0 590.3 594.3 594.9 38748.6 39440.8 39601.0 39615.4 39623.6 42372.4 42805.1 42956.1 42967.6 43089.0 7548.8 7696.6 8577.1 8780.8 9901.9 10048.9 10177.7 10200.4 10205.0 10207.4 10230.7 10358.8 10375.8 10386.3 10386.4 7828.6 8051.8 10053.3 10246.8 10286.2 9785.2 9859.3 9913.1 9919.2 9919.7 39129.6 39578.6 39601.6 39606.4 39703.4 3370.4 3472.8 3567.5 3657.8 3787.4 30229.4 30547.8 30617.7 30711.7 30771.4 3513.6 3589.3 3608.2 3642.4 3695.6 281691.0 282280.0 282631.0 283136.0 283939.0 55041.0 55776.7 55885.0 57006.4 57485.0 57608.4 57625.4 57802.0 58114.1 58244.4 14408.2 14684.0 14687.9 14708.1 14736.8 10806.3 10850.1 10880.7 10882.1 10894.6 18928.6 19000.6 19137.8 19166.3 19201.4 7158.6 7319.5 7417.7 7457.2 7468.2 925.1 979.9 1033.2 1057.6 1070.1 28605.1 28903.1 28917.9 29228.0 29304.9 989.4 998.3 999.2 1099.0 1115.2 13515.9 13641.8 13726.3 13858.3 13870.2 324270.0 328828.0 330631.0 331929.0 332163.0 46250.8 46400.5 46440.8 46487.3 46524.8 1348.6 1352.1 1370.3 1370.9 1373.1 23186.4 27925.3 28429.1 28821.9 28952.0 47057.3 48612.5 48634.0 48663.5 48761.3 274159.0 275888.0 276936.0 276947.0 277385.0 28096.0 28462.6 31168.8 31235.2 31940.7 42150.2 42398.0 42610.0 43096.0 43502.8 35885.0 35997.8 36100.8 36983.8 37156.6 35837.3 36025.8 36424.6 36627.8 36637.6 35909.2 35916.5 36074.1 36334.8 36353.6 31636.8 32588.2 32597.5 32701.5 32882.3 24802.1 24968.5 25030.4 25118.6 25348.7 14:04:59 INFO - 2015-11-13 14:04:59,586 DEBUG : BROWSER_OUTPUT: 14:04:59 INFO - 2015-11-13 14:04:59,586 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22545.79 Median:23175.02 stddev:60451.29 (260.8%) stddev-sans-first:60597.88 14:04:59 INFO - 2015-11-13 14:04:59,587 DEBUG : BROWSER_OUTPUT: Values: 340.4 341.8 344.7 347.4 347.5 14548.3 14881.3 16476.4 16716.4 17574.2 14849.3 14959.6 15693.5 15870.9 15981.1 5081.7 5313.8 5329.8 5333.2 5343.3 3990.8 4087.6 5282.8 5766.8 5922.0 5814.3 5846.2 5847.0 5860.2 5869.2 5677.3 5750.9 5780.9 5782.9 5785.1 4990.9 4995.2 5012.9 5017.7 5022.1 20604.5 20689.3 20986.4 21098.7 21262.9 2035.3 2064.9 2116.9 2154.1 2192.0 11818.9 12022.0 12064.6 12137.9 12191.1 1815.7 1820.4 1830.7 1867.0 1870.1 55558.7 56150.7 57280.0 60291.1 61026.4 6715.6 6900.4 6966.1 7010.8 7047.7 8388.0 8399.7 8408.5 8408.8 8413.2 5560.8 5573.4 5580.9 5603.8 5608.9 5743.7 5744.1 5758.3 5781.2 5782.8 3249.5 3255.3 3270.1 3278.4 3281.0 1102.5 1105.5 1106.0 1107.3 1148.9 460.5 477.8 478.9 485.7 499.8 11415.4 11553.4 11772.0 11803.0 11874.1 496.7 498.2 507.8 523.5 531.6 6345.8 6546.6 6564.2 6621.8 6817.7 361136.0 361345.0 362961.0 365336.0 376941.0 76753.0 77117.6 79008.6 79400.0 80074.2 514.4 529.0 532.3 532.6 532.9 10633.5 10737.2 10796.4 11059.7 11103.2 34843.0 34928.5 35890.3 35912.8 36009.6 43033.0 45889.5 47618.8 49153.8 49340.0 6725.3 6765.5 6831.4 6833.8 6840.8 12516.9 12716.9 12772.0 12837.2 12930.2 9220.2 9608.9 9765.3 11013.2 11132.6 10470.3 10697.4 10823.8 10850.3 10871.1 11187.1 11219.6 11423.9 11468.9 11596.4 5690.5 6780.3 6893.5 6907.6 6939.8 10947.8 11097.7 11282.5 11284.3 11332.2 14:04:59 INFO - 2015-11-13 14:04:59,587 DEBUG : BROWSER_OUTPUT: 14:04:59 INFO - 2015-11-13 14:04:59,587 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5165.10 Median:6148.81 stddev:2695.98 (43.8%) stddev-sans-first:2688.09 14:04:59 INFO - 2015-11-13 14:04:59,589 DEBUG : BROWSER_OUTPUT: Values: 1324.5 1656.7 1678.4 1703.4 1709.7 6357.6 6887.2 7066.9 7075.9 7077.7 7213.2 7333.1 7354.6 7357.6 7377.6 1908.5 1929.7 2115.4 2125.9 2154.9 2218.9 2223.4 2226.4 2227.1 2227.9 2158.5 2213.2 2213.7 2216.3 2218.7 1881.6 1906.1 2105.0 2136.5 2141.3 2168.5 2179.7 2203.0 2207.1 2235.4 7428.5 7490.1 7493.6 7502.4 7503.0 4421.1 4500.8 4537.0 4546.2 4547.4 2903.4 2948.3 2969.0 2985.1 3047.6 848.1 854.2 870.8 946.9 1878.3 10014.7 10095.4 10099.3 10111.2 10132.6 3929.4 4014.6 4064.7 4085.7 4095.2 8053.4 8090.3 8097.4 8100.0 8119.0 4428.7 4443.7 4467.0 4484.3 4491.1 4042.0 4054.8 4081.0 4088.6 4090.0 3281.6 3308.2 3337.7 3341.7 3342.9 1011.5 1018.6 1022.9 1034.1 1034.5 1023.1 1032.0 1032.7 1157.2 1309.9 6882.1 6974.1 6984.3 6988.3 7013.6 477.8 478.6 486.4 487.5 491.1 5521.6 5579.7 5580.7 5581.7 5584.7 8768.2 8893.1 9067.9 9069.0 9165.5 8946.2 9068.9 9107.5 9156.2 9171.4 6889.0 7017.9 7076.5 7127.4 7134.9 6731.6 6790.0 6805.4 6810.6 6827.9 7593.1 7859.4 7926.9 7932.1 8025.0 7990.1 8160.6 8190.2 8332.6 8338.7 6337.7 6368.6 6380.4 6445.1 6461.6 7243.1 7315.6 7330.0 7333.2 7343.9 6794.2 6944.9 6961.7 7020.7 7036.6 5742.8 5770.0 5819.2 6646.3 6717.0 6802.2 6846.3 6850.6 6851.2 6855.3 6068.5 6136.3 6161.4 6224.3 6239.9 6274.4 6318.2 6318.8 6330.8 6340.5 14:04:59 INFO - 2015-11-13 14:04:59,589 DEBUG : BROWSER_OUTPUT: 14:04:59 INFO - 2015-11-13 14:04:59,589 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5346.73 Median:6142.09 stddev:1672.86 (27.2%) stddev-sans-first:1634.52 14:04:59 INFO - 2015-11-13 14:04:59,589 DEBUG : BROWSER_OUTPUT: Values: 323.6 325.4 326.0 328.3 333.2 6082.5 6127.8 6138.1 6146.1 6176.2 5999.8 6028.7 6033.4 6044.8 6045.5 4600.7 4611.7 4612.4 4612.8 4613.1 4348.0 4449.7 4459.2 4466.7 4611.6 4429.7 4433.0 4438.8 4439.4 4446.8 4275.8 4356.1 4443.6 4446.3 4451.9 3725.3 3732.9 3733.3 3737.5 3815.4 5688.9 5691.0 5707.8 5738.3 5744.2 5254.6 5262.3 5277.1 5279.6 5288.8 5977.0 6095.7 6305.9 6366.7 6439.9 4231.8 4232.2 4233.1 4239.1 4249.4 6594.7 6610.7 6677.3 6682.1 6693.8 4406.0 4416.0 4425.0 4426.4 4431.8 4377.7 4423.2 4444.0 4451.9 4462.3 5233.0 5240.0 5240.4 5247.6 5248.6 6477.5 6479.5 6485.6 6492.2 6492.9 1539.1 1541.3 1542.3 1545.8 1547.1 1022.2 1024.3 1028.3 1050.0 1051.9 6194.5 6196.3 6203.0 6203.8 6208.5 6651.5 6658.2 6662.7 6671.2 6679.0 6024.8 6175.0 6199.6 6199.8 6209.9 3507.5 3602.5 3626.3 3628.8 3630.1 6797.0 6875.8 6904.5 6912.9 7028.5 6795.2 6798.4 6805.8 6816.4 6824.9 6790.1 6944.4 6964.2 6972.3 6976.3 6667.9 6699.9 6715.1 6719.2 6731.6 6646.5 6649.4 6650.8 6652.7 6654.2 6815.0 6975.1 6976.4 6979.3 6986.1 4444.0 4445.8 4447.0 4448.1 4450.1 6671.4 6682.3 6682.4 6691.3 6692.9 6371.8 6506.8 6508.0 6522.9 6528.5 6521.9 6523.7 6526.2 6527.0 6530.1 6411.1 6413.7 6414.7 6422.5 6431.2 6403.5 6545.3 6554.4 6556.1 6564.2 6398.6 6400.1 6400.1 6402.9 6406.1 14:04:59 INFO - 2015-11-13 14:04:59,589 DEBUG : BROWSER_OUTPUT: 14:04:59 INFO - 2015-11-13 14:04:59,589 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13492.21 Median:473.65 stddev:15481.47 (3268.6%) stddev-sans-first:15495.35 14:04:59 INFO - 2015-11-13 14:04:59,589 DEBUG : BROWSER_OUTPUT: Values: 753.5 755.4 757.4 773.8 809.2 14088.8 14196.1 14232.3 14263.0 14264.0 13408.9 13505.1 13507.5 13534.9 13546.8 668.8 684.9 805.5 806.5 820.8 817.3 820.8 825.2 827.4 827.7 864.8 868.9 871.1 871.2 871.2 712.6 720.5 854.9 858.1 868.3 637.3 637.5 638.7 639.1 639.1 13464.3 13538.1 13547.7 13555.4 13593.8 12107.2 12260.6 12269.8 12507.9 12939.6 10025.8 10521.1 10564.6 10679.6 10725.7 3655.5 3668.1 3676.8 3690.6 3812.2 47668.3 47717.5 47878.3 48211.0 49034.8 9428.9 9430.8 9466.4 9504.3 9543.4 18103.8 18106.4 18194.5 18277.5 18295.2 7926.3 8009.6 8027.0 8079.6 8272.3 4148.0 4163.0 4305.9 4335.8 4354.5 3133.0 3141.1 3141.3 3141.3 3149.2 459.7 468.9 473.0 474.3 487.8 657.3 665.6 665.8 675.8 698.1 7719.4 8421.0 8606.7 8717.4 8900.5 529.2 698.8 709.9 710.2 716.7 3728.3 3865.0 3914.5 3930.7 3960.0 51674.7 52137.0 52171.5 57577.1 57604.0 46422.1 46628.8 47116.3 47670.5 50759.5 45650.3 45972.3 46029.3 46195.8 47052.8 8218.9 8400.2 8422.2 8438.7 8484.2 34525.8 35250.6 35337.5 35515.6 36280.3 41372.6 43923.6 44700.8 44808.0 44863.3 7986.9 8013.6 8196.8 8341.5 8385.2 12233.4 12326.1 12543.7 12676.0 12777.4 10577.2 10629.6 10978.1 11057.0 11478.5 10604.8 10801.2 10843.0 10866.2 11209.8 7894.0 10498.7 10987.7 11036.8 11196.7 9494.0 9530.5 9753.3 9877.2 10204.4 9117.4 9301.8 9344.6 9375.6 9552.3 14:04:59 INFO - 2015-11-13 14:04:59,589 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:04:59 INFO - 2015-11-13 14:04:59,589 DEBUG : BROWSER_OUTPUT: 14:05:00 INFO - 2015-11-13 14:05:00,350 INFO : Browser exited with error code: 0 14:05:00 INFO - 2015-11-13 14:05:00,373 INFO : Completed test dromaeo_css (00:18:35) 14:05:00 INFO - 2015-11-13 14:05:00,373 INFO : Starting test kraken 14:05:00 INFO - 2015-11-13 14:05:00,373 DEBUG : operating with platform_type : linux_ 14:05:00 INFO - 2015-11-13 14:05:00,373 INFO : Initialising browser for kraken test... 14:05:00 INFO - 2015-11-13 14:05:00,379 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1yHqC1/profile http://localhost:48827/getInfo.html 14:05:05 INFO - 2015-11-13 14:05:05,242 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:05:05 INFO - 2015-11-13 14:05:05,242 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:05:05 INFO - 2015-11-13 14:05:05,242 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:05:05 INFO - 2015-11-13 14:05:05,242 DEBUG : BROWSER_OUTPUT: __metrics 14:05:05 INFO - 2015-11-13 14:05:05,359 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:05:07 INFO - 2015-11-13 14:05:07,100 INFO : Browser initialized. 14:05:07 INFO - 2015-11-13 14:05:07,101 INFO : Running cycle 1/1 for kraken test... 14:05:07 INFO - 2015-11-13 14:05:07,101 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1yHqC1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:05:18 INFO - 2015-11-13 14:05:18,891 DEBUG : BROWSER_OUTPUT: RSS: Main: 141295616 14:05:18 INFO - 2015-11-13 14:05:18,892 DEBUG : BROWSER_OUTPUT: 14:05:21 INFO - 2015-11-13 14:05:21,339 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48827/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48827/tests/kraken/driver.html?testName=audio-beat-detection) 14:05:21 INFO - 2015-11-13 14:05:21,912 DEBUG : BROWSER_OUTPUT: RSS: Main: 182972416 14:05:21 INFO - 2015-11-13 14:05:21,912 DEBUG : BROWSER_OUTPUT: 14:05:24 INFO - 2015-11-13 14:05:24,508 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48827/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48827/tests/kraken/driver.html?testName=audio-dft) 14:05:25 INFO - 2015-11-13 14:05:25,090 DEBUG : BROWSER_OUTPUT: RSS: Main: 172556288 14:05:25 INFO - 2015-11-13 14:05:25,090 DEBUG : BROWSER_OUTPUT: 14:05:28 INFO - 2015-11-13 14:05:28,049 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48827/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48827/tests/kraken/driver.html?testName=audio-fft) 14:05:28 INFO - 2015-11-13 14:05:28,610 DEBUG : BROWSER_OUTPUT: RSS: Main: 150982656 14:05:28 INFO - 2015-11-13 14:05:28,610 DEBUG : BROWSER_OUTPUT: 14:05:30 INFO - 2015-11-13 14:05:30,586 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48827/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48827/tests/kraken/driver.html?testName=audio-oscillator) 14:05:31 INFO - 2015-11-13 14:05:31,151 DEBUG : BROWSER_OUTPUT: RSS: Main: 152002560 14:05:31 INFO - 2015-11-13 14:05:31,151 DEBUG : BROWSER_OUTPUT: 14:05:33 INFO - 2015-11-13 14:05:33,306 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48827/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48827/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:05:33 INFO - 2015-11-13 14:05:33,867 DEBUG : BROWSER_OUTPUT: RSS: Main: 155078656 14:05:33 INFO - 2015-11-13 14:05:33,867 DEBUG : BROWSER_OUTPUT: 14:05:36 INFO - 2015-11-13 14:05:36,829 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48827/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48827/tests/kraken/driver.html?testName=imaging-darkroom) 14:05:37 INFO - 2015-11-13 14:05:37,403 DEBUG : BROWSER_OUTPUT: RSS: Main: 154402816 14:05:37 INFO - 2015-11-13 14:05:37,403 DEBUG : BROWSER_OUTPUT: 14:05:40 INFO - 2015-11-13 14:05:40,790 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48827/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48827/tests/kraken/driver.html?testName=imaging-desaturate) 14:05:41 INFO - 2015-11-13 14:05:41,356 DEBUG : BROWSER_OUTPUT: RSS: Main: 155119616 14:05:41 INFO - 2015-11-13 14:05:41,356 DEBUG : BROWSER_OUTPUT: 14:05:44 INFO - 2015-11-13 14:05:44,118 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48827/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48827/tests/kraken/driver.html?testName=json-parse-financial) 14:05:44 INFO - 2015-11-13 14:05:44,699 DEBUG : BROWSER_OUTPUT: RSS: Main: 156364800 14:05:44 INFO - 2015-11-13 14:05:44,700 DEBUG : BROWSER_OUTPUT: 14:05:46 INFO - 2015-11-13 14:05:46,227 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48827/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48827/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:05:46 INFO - 2015-11-13 14:05:46,788 DEBUG : BROWSER_OUTPUT: RSS: Main: 166633472 14:05:46 INFO - 2015-11-13 14:05:46,788 DEBUG : BROWSER_OUTPUT: 14:05:48 INFO - 2015-11-13 14:05:48,550 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48827/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48827/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:05:49 INFO - 2015-11-13 14:05:49,156 DEBUG : BROWSER_OUTPUT: RSS: Main: 165023744 14:05:49 INFO - 2015-11-13 14:05:49,156 DEBUG : BROWSER_OUTPUT: 14:05:51 INFO - 2015-11-13 14:05:51,208 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48827/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48827/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:05:51 INFO - 2015-11-13 14:05:51,774 DEBUG : BROWSER_OUTPUT: RSS: Main: 177217536 14:05:51 INFO - 2015-11-13 14:05:51,774 DEBUG : BROWSER_OUTPUT: 14:05:54 INFO - 2015-11-13 14:05:54,188 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48827/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48827/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:05:54 INFO - 2015-11-13 14:05:54,769 DEBUG : BROWSER_OUTPUT: RSS: Main: 182235136 14:05:54 INFO - 2015-11-13 14:05:54,770 DEBUG : BROWSER_OUTPUT: 14:05:57 INFO - 2015-11-13 14:05:57,304 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48827/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48827/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:05:57 INFO - 2015-11-13 14:05:57,865 DEBUG : BROWSER_OUTPUT: RSS: Main: 178630656 14:05:57 INFO - 2015-11-13 14:05:57,866 DEBUG : BROWSER_OUTPUT: 14:05:59 INFO - 2015-11-13 14:05:59,519 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48827/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48827/tests/kraken/driver.html?testName=ai-astar) 14:05:59 INFO - 2015-11-13 14:05:59,770 DEBUG : BROWSER_OUTPUT: RSS: Main: 238129152 14:05:59 INFO - 2015-11-13 14:05:59,770 DEBUG : BROWSER_OUTPUT: 14:05:59 INFO - 2015-11-13 14:05:59,770 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:05:59 INFO - 2015-11-13 14:05:59,770 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:05:59 INFO - 2015-11-13 14:05:59,770 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:05:59 INFO - 2015-11-13 14:05:59,770 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:05:59 INFO - 2015-11-13 14:05:59,770 DEBUG : BROWSER_OUTPUT: |0;ai-astar;107;109;104;109;110;112;100;109;109;107 14:05:59 INFO - 2015-11-13 14:05:59,771 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;130;145;170;124;157;148;125;160;125 14:05:59 INFO - 2015-11-13 14:05:59,771 DEBUG : BROWSER_OUTPUT: |2;audio-dft;175;172;172;171;170;171;169;171;171;169 14:05:59 INFO - 2015-11-13 14:05:59,771 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;72;92;72;72;72;94;90;71 14:05:59 INFO - 2015-11-13 14:05:59,771 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;91;136;91;91;90;138;90;91;137 14:05:59 INFO - 2015-11-13 14:05:59,771 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;109;109;109;109;109;110;109 14:05:59 INFO - 2015-11-13 14:05:59,771 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;144;145;144;146;145;145;145;145;145;146 14:05:59 INFO - 2015-11-13 14:05:59,771 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;95;95;96;95;95;95 14:05:59 INFO - 2015-11-13 14:05:59,771 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;57;56;56;56;56;57;65;54;55 14:05:59 INFO - 2015-11-13 14:05:59,772 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;67;67;66;66;66;67;68;66;67 14:05:59 INFO - 2015-11-13 14:05:59,772 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;85;85;84;84;83;83;84;84;92 14:05:59 INFO - 2015-11-13 14:05:59,772 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;116;124;119;115;122;126;133;116;121 14:05:59 INFO - 2015-11-13 14:05:59,772 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;153;147;144;141;147;140;151;154;154;144 14:05:59 INFO - 2015-11-13 14:05:59,772 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;67;66;66;66;66;68;66;68;66 14:05:59 INFO - 2015-11-13 14:05:59,772 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:05:59 INFO - 2015-11-13 14:05:59,772 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:05:59 INFO - 2015-11-13 14:05:59,773 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,902 14:05:59 INFO - 2015-11-13 14:05:59,773 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:05:59 INFO - 2015-11-13 14:05:59,773 DEBUG : BROWSER_OUTPUT: __startTimestamp1447452359768__endTimestamp 14:05:59 INFO - 2015-11-13 14:05:59,773 DEBUG : BROWSER_OUTPUT: 14:05:59 INFO - 2015-11-13 14:05:59,774 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:05:59 INFO - 2015-11-13 14:05:59,775 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:05:59 INFO - 2015-11-13 14:05:59,775 DEBUG : BROWSER_OUTPUT: 14:05:59 INFO - 2015-11-13 14:05:59,775 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.60 Median:109.00 stddev:3.41 (3.1%) stddev-sans-first:3.61 14:05:59 INFO - 2015-11-13 14:05:59,776 DEBUG : BROWSER_OUTPUT: Values: 107.0 109.0 104.0 109.0 110.0 112.0 100.0 109.0 109.0 107.0 14:05:59 INFO - 2015-11-13 14:05:59,777 DEBUG : BROWSER_OUTPUT: 14:05:59 INFO - 2015-11-13 14:05:59,777 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.80 Median:151.00 stddev:16.78 (11.1%) stddev-sans-first:17.39 14:05:59 INFO - 2015-11-13 14:05:59,777 DEBUG : BROWSER_OUTPUT: Values: 154.0 130.0 145.0 170.0 124.0 157.0 148.0 125.0 160.0 125.0 14:05:59 INFO - 2015-11-13 14:05:59,777 DEBUG : BROWSER_OUTPUT: 14:05:59 INFO - 2015-11-13 14:05:59,777 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:171.10 Median:171.00 stddev:1.73 (1.0%) stddev-sans-first:1.12 14:05:59 INFO - 2015-11-13 14:05:59,778 DEBUG : BROWSER_OUTPUT: Values: 175.0 172.0 172.0 171.0 170.0 171.0 169.0 171.0 171.0 169.0 14:05:59 INFO - 2015-11-13 14:05:59,778 DEBUG : BROWSER_OUTPUT: 14:05:59 INFO - 2015-11-13 14:05:59,778 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:77.80 Median:72.00 stddev:9.85 (13.7%) stddev-sans-first:10.22 14:05:59 INFO - 2015-11-13 14:05:59,778 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 72.0 92.0 72.0 72.0 72.0 94.0 90.0 71.0 14:05:59 INFO - 2015-11-13 14:05:59,778 DEBUG : BROWSER_OUTPUT: 14:05:59 INFO - 2015-11-13 14:05:59,778 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.50 Median:90.50 stddev:22.44 (24.8%) stddev-sans-first:23.18 14:05:59 INFO - 2015-11-13 14:05:59,778 DEBUG : BROWSER_OUTPUT: Values: 90.0 91.0 136.0 91.0 91.0 90.0 138.0 90.0 91.0 137.0 14:05:59 INFO - 2015-11-13 14:05:59,778 DEBUG : BROWSER_OUTPUT: 14:05:59 INFO - 2015-11-13 14:05:59,779 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:05:59 INFO - 2015-11-13 14:05:59,779 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 14:05:59 INFO - 2015-11-13 14:05:59,779 DEBUG : BROWSER_OUTPUT: 14:05:59 INFO - 2015-11-13 14:05:59,779 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 14:05:59 INFO - 2015-11-13 14:05:59,779 DEBUG : BROWSER_OUTPUT: Values: 144.0 145.0 144.0 146.0 145.0 145.0 145.0 145.0 145.0 146.0 14:05:59 INFO - 2015-11-13 14:05:59,779 DEBUG : BROWSER_OUTPUT: 14:05:59 INFO - 2015-11-13 14:05:59,779 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 14:05:59 INFO - 2015-11-13 14:05:59,779 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 14:05:59 INFO - 2015-11-13 14:05:59,779 DEBUG : BROWSER_OUTPUT: 14:05:59 INFO - 2015-11-13 14:05:59,779 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.90 Median:56.50 stddev:3.00 (5.3%) stddev-sans-first:3.18 14:05:59 INFO - 2015-11-13 14:05:59,780 DEBUG : BROWSER_OUTPUT: Values: 57.0 57.0 56.0 56.0 56.0 56.0 57.0 65.0 54.0 55.0 14:05:59 INFO - 2015-11-13 14:05:59,780 DEBUG : BROWSER_OUTPUT: 14:05:59 INFO - 2015-11-13 14:05:59,780 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 14:05:59 INFO - 2015-11-13 14:05:59,780 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 67.0 66.0 66.0 66.0 67.0 68.0 66.0 67.0 14:05:59 INFO - 2015-11-13 14:05:59,780 DEBUG : BROWSER_OUTPUT: 14:05:59 INFO - 2015-11-13 14:05:59,780 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.50 stddev:2.60 (3.1%) stddev-sans-first:2.76 14:05:59 INFO - 2015-11-13 14:05:59,780 DEBUG : BROWSER_OUTPUT: Values: 85.0 85.0 85.0 84.0 84.0 83.0 83.0 84.0 84.0 92.0 14:05:59 INFO - 2015-11-13 14:05:59,780 DEBUG : BROWSER_OUTPUT: 14:05:59 INFO - 2015-11-13 14:05:59,780 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.50 Median:122.50 stddev:5.48 (4.5%) stddev-sans-first:5.79 14:05:59 INFO - 2015-11-13 14:05:59,781 DEBUG : BROWSER_OUTPUT: Values: 123.0 116.0 124.0 119.0 115.0 122.0 126.0 133.0 116.0 121.0 14:05:59 INFO - 2015-11-13 14:05:59,781 DEBUG : BROWSER_OUTPUT: 14:05:59 INFO - 2015-11-13 14:05:59,781 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.50 Median:149.00 stddev:5.28 (3.5%) stddev-sans-first:5.21 14:05:59 INFO - 2015-11-13 14:05:59,781 DEBUG : BROWSER_OUTPUT: Values: 153.0 147.0 144.0 141.0 147.0 140.0 151.0 154.0 154.0 144.0 14:05:59 INFO - 2015-11-13 14:05:59,781 DEBUG : BROWSER_OUTPUT: 14:05:59 INFO - 2015-11-13 14:05:59,782 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:66.50 stddev:0.95 (1.4%) stddev-sans-first:0.88 14:05:59 INFO - 2015-11-13 14:05:59,782 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 66.0 66.0 66.0 66.0 68.0 66.0 68.0 66.0 14:05:59 INFO - 2015-11-13 14:05:59,782 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:05:59 INFO - 2015-11-13 14:05:59,783 DEBUG : BROWSER_OUTPUT: 14:06:00 INFO - 2015-11-13 14:06:00,750 INFO : Browser exited with error code: 0 14:06:00 INFO - 2015-11-13 14:06:00,800 INFO : Completed test kraken (00:01:00) 14:06:00 INFO - 2015-11-13 14:06:00,800 INFO : Starting test v8_7 14:06:00 INFO - 2015-11-13 14:06:00,801 DEBUG : operating with platform_type : linux_ 14:06:00 INFO - 2015-11-13 14:06:00,801 INFO : Initialising browser for v8_7 test... 14:06:00 INFO - 2015-11-13 14:06:00,807 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgR0EiT/profile http://localhost:48827/getInfo.html 14:06:05 INFO - 2015-11-13 14:06:05,549 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:06:05 INFO - 2015-11-13 14:06:05,549 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:06:05 INFO - 2015-11-13 14:06:05,549 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:06:05 INFO - 2015-11-13 14:06:05,549 DEBUG : BROWSER_OUTPUT: __metrics 14:06:05 INFO - 2015-11-13 14:06:05,670 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:06:07 INFO - 2015-11-13 14:06:07,327 INFO : Browser initialized. 14:06:07 INFO - 2015-11-13 14:06:07,327 INFO : Running cycle 1/1 for v8_7 test... 14:06:07 INFO - 2015-11-13 14:06:07,328 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgR0EiT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:06:19 INFO - 2015-11-13 14:06:19,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 141205504 14:06:19 INFO - 2015-11-13 14:06:19,004 DEBUG : BROWSER_OUTPUT: 14:06:40 INFO - 2015-11-13 14:06:40,392 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48827/tests/v8_7/run.html (next: http://localhost:48827/tests/v8_7/run.html) 14:06:40 INFO - 2015-11-13 14:06:40,650 DEBUG : BROWSER_OUTPUT: RSS: Main: 611209216 14:06:40 INFO - 2015-11-13 14:06:40,650 DEBUG : BROWSER_OUTPUT: 14:06:40 INFO - 2015-11-13 14:06:40,650 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:06:40 INFO - 2015-11-13 14:06:40,650 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:06:40 INFO - 2015-11-13 14:06:40,650 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:06:40 INFO - 2015-11-13 14:06:40,651 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:06:40 INFO - 2015-11-13 14:06:40,651 DEBUG : BROWSER_OUTPUT: |0;Richards;170.06802721088437 14:06:40 INFO - 2015-11-13 14:06:40,651 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.21246844047388 14:06:40 INFO - 2015-11-13 14:06:40,651 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.7695125387433 14:06:40 INFO - 2015-11-13 14:06:40,651 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 14:06:40 INFO - 2015-11-13 14:06:40,651 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1095.290251916758 14:06:40 INFO - 2015-11-13 14:06:40,651 DEBUG : BROWSER_OUTPUT: |5;Earley;784.9293563579278 14:06:40 INFO - 2015-11-13 14:06:40,651 DEBUG : BROWSER_OUTPUT: |6;Boyer;12060.240963855422 14:06:40 INFO - 2015-11-13 14:06:40,651 DEBUG : BROWSER_OUTPUT: |7;RegExp;27432.432432432433 14:06:40 INFO - 2015-11-13 14:06:40,651 DEBUG : BROWSER_OUTPUT: |8;Splay;622.66500622665 14:06:40 INFO - 2015-11-13 14:06:40,651 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 14:06:40 INFO - 2015-11-13 14:06:40,651 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:06:40 INFO - 2015-11-13 14:06:40,651 DEBUG : BROWSER_OUTPUT: __startTimestamp1447452400643__endTimestamp 14:06:40 INFO - 2015-11-13 14:06:40,652 DEBUG : BROWSER_OUTPUT: 14:06:40 INFO - 2015-11-13 14:06:40,652 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:06:40 INFO - 2015-11-13 14:06:40,652 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:06:40 INFO - 2015-11-13 14:06:40,652 DEBUG : BROWSER_OUTPUT: 14:06:40 INFO - 2015-11-13 14:06:40,652 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:170.07 Median:170.07 stddev:0.00 (0.0%) 14:06:40 INFO - 2015-11-13 14:06:40,652 DEBUG : BROWSER_OUTPUT: Values: 170.1 14:06:40 INFO - 2015-11-13 14:06:40,652 DEBUG : BROWSER_OUTPUT: 14:06:40 INFO - 2015-11-13 14:06:40,652 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.21 Median:194.21 stddev:0.00 (0.0%) 14:06:40 INFO - 2015-11-13 14:06:40,652 DEBUG : BROWSER_OUTPUT: Values: 194.2 14:06:40 INFO - 2015-11-13 14:06:40,652 DEBUG : BROWSER_OUTPUT: 14:06:40 INFO - 2015-11-13 14:06:40,652 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.77 Median:281.77 stddev:0.00 (0.0%) 14:06:40 INFO - 2015-11-13 14:06:40,652 DEBUG : BROWSER_OUTPUT: Values: 281.8 14:06:40 INFO - 2015-11-13 14:06:40,652 DEBUG : BROWSER_OUTPUT: 14:06:40 INFO - 2015-11-13 14:06:40,652 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 14:06:40 INFO - 2015-11-13 14:06:40,652 DEBUG : BROWSER_OUTPUT: Values: 5035.2 14:06:40 INFO - 2015-11-13 14:06:40,652 DEBUG : BROWSER_OUTPUT: 14:06:40 INFO - 2015-11-13 14:06:40,653 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1095.29 Median:1095.29 stddev:0.00 (0.0%) 14:06:40 INFO - 2015-11-13 14:06:40,653 DEBUG : BROWSER_OUTPUT: Values: 1095.3 14:06:40 INFO - 2015-11-13 14:06:40,653 DEBUG : BROWSER_OUTPUT: 14:06:40 INFO - 2015-11-13 14:06:40,653 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:784.93 Median:784.93 stddev:0.00 (0.0%) 14:06:40 INFO - 2015-11-13 14:06:40,653 DEBUG : BROWSER_OUTPUT: Values: 784.9 14:06:40 INFO - 2015-11-13 14:06:40,653 DEBUG : BROWSER_OUTPUT: 14:06:40 INFO - 2015-11-13 14:06:40,653 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12060.24 Median:12060.24 stddev:0.00 (0.0%) 14:06:40 INFO - 2015-11-13 14:06:40,653 DEBUG : BROWSER_OUTPUT: Values: 12060.2 14:06:40 INFO - 2015-11-13 14:06:40,653 DEBUG : BROWSER_OUTPUT: 14:06:40 INFO - 2015-11-13 14:06:40,653 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27432.43 Median:27432.43 stddev:0.00 (0.0%) 14:06:40 INFO - 2015-11-13 14:06:40,653 DEBUG : BROWSER_OUTPUT: Values: 27432.4 14:06:40 INFO - 2015-11-13 14:06:40,653 DEBUG : BROWSER_OUTPUT: 14:06:40 INFO - 2015-11-13 14:06:40,653 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:622.67 Median:622.67 stddev:0.00 (0.0%) 14:06:40 INFO - 2015-11-13 14:06:40,653 DEBUG : BROWSER_OUTPUT: Values: 622.7 14:06:40 INFO - 2015-11-13 14:06:40,653 DEBUG : BROWSER_OUTPUT: 14:06:40 INFO - 2015-11-13 14:06:40,654 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 14:06:40 INFO - 2015-11-13 14:06:40,654 DEBUG : BROWSER_OUTPUT: Values: 4830.9 14:06:40 INFO - 2015-11-13 14:06:40,654 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:06:40 INFO - 2015-11-13 14:06:40,654 DEBUG : BROWSER_OUTPUT: 14:06:41 INFO - 2015-11-13 14:06:41,625 INFO : Browser exited with error code: 0 14:06:41 INFO - 2015-11-13 14:06:41,638 INFO : Completed test v8_7 (00:00:40) 14:06:41 INFO - 2015-11-13 14:06:41,676 INFO : Completed test suite (00:20:16) 14:06:41 INFO - 2015-11-13 14:06:41,677 DEBUG : Working with test: dromaeo_css 14:06:41 INFO - 2015-11-13 14:06:41,677 DEBUG : Generating results file: dromaeo_css 14:06:41 INFO - 2015-11-13 14:06:41,679 DEBUG : Working with test: kraken 14:06:41 INFO - 2015-11-13 14:06:41,679 DEBUG : Generating results file: kraken 14:06:41 INFO - 2015-11-13 14:06:41,679 INFO : javascript benchmark 14:06:41 INFO - 2015-11-13 14:06:41,680 DEBUG : Working with test: v8_7 14:06:41 INFO - 2015-11-13 14:06:41,680 DEBUG : Generating results file: v8_7 14:06:41 INFO - 2015-11-13 14:06:41,680 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:06:41 INFO - 2015-11-13 14:06:41,738 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 14:06:41 INFO - 2015-11-13 14:06:41,738 DEBUG : process_Request line: dromaeo_css 6705.44 graph.html#tests=[[72,64,35]] 14:06:41 INFO - 2015-11-13 14:06:41,739 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:06:41 INFO - 2015-11-13 14:06:41,765 DEBUG : process_Request line: kraken 1498.40 graph.html#tests=[[232,64,35]] 14:06:41 INFO - 2015-11-13 14:06:41,765 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:06:41 INFO - 2015-11-13 14:06:41,796 DEBUG : process_Request line: v8_7 20854.32 graph.html#tests=[[230,64,35]] 14:06:41 INFO - 2015-11-13 14:06:41,797 INFO : javascript benchmark 14:06:41 INFO - 2015-11-13 14:06:41,801 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [340.4059915447543, 341.8154196733763, 344.70183291452895, 347.3608560249141, 347.494395654323, 14548.272586370666, 14881.255937203123, 16476.42332518362, 16716.414925477595, 17574.209160587787, 14849.257537123154, 14959.626009349771, 15693.45072922448, 15870.920645396756, 15981.121038342886, 5081.6696914700515, 5313.760880760356, 5329.786808527654, 5333.173358129477, 5343.332083489564, 3990.8403663853555, 4087.591240875918, 5282.762275697583, 5766.82699519013, 5922.022866227089, 5814.273215848019, 5846.2107615472005, 5847.0, 5860.179574859523, 5869.178315035899, 5677.318721753375, 5750.913736293917, 5780.855478613026, 5782.884342313172, 5785.132230165466, 4990.850274491771, 4995.200767877122, 5012.924806127911, 5017.7491125443585, 5022.096022715946, 20604.454665899968, 20689.27587534444, 20986.370408887604, 21098.683519747217, 21262.893685531628, 2035.297822251321, 2064.917403303866, 2116.883571403572, 2154.1168121070286, 2192.0, 11818.881811181951, 12022.038236941024, 12064.638060858188, 12137.939310303393, 12191.146619736623, 1815.7094864821697, 1820.399268241477, 1830.7253911913187, 1866.9626607467774, 1870.1397357215697, 55558.72220638912, 56150.71924640392, 57280.0, 60291.09563356553, 61026.389736102516, 6715.56348837324, 6900.447964162855, 6966.059581956472, 7010.824729381806, 7047.718091276394, 8388.035375931846, 8399.748007559661, 8408.453450525696, 8408.789780255542, 8413.200745929127, 5560.833175004756, 5573.41479144692, 5580.888382232414, 5603.831885043455, 5608.9439105609235, 5743.684097374601, 5744.138379243063, 5758.2514273144225, 5781.161731548902, 5782.826515204551, 3249.4638384666264, 3255.283837555734, 3270.05168501132, 3278.3607196596436, 3281.032095531824, 1102.4653043274006, 1105.4693747001484, 1105.9612913548149, 1107.2692023264767, 1148.9253198542067, 460.5026571303052, 477.801712289403, 478.93534372859216, 485.66003797342, 499.78009675742555, 11415.42922853854, 11553.422328883522, 11772.0, 11803.0, 11874.1094417919, 496.74417674897455, 498.1804930888668, 507.84510724229466, 523.4660646140991, 531.6464551073493, 6345.841353966095, 6546.639934803631, 6564.179477565304, 6621.834454138685, 6817.659117044128, 361136.0, 361345.0, 362961.0, 365336.0, 376941.0, 76753.0, 77117.61441192759, 79008.60495697484, 79400.0, 80074.19925800667, 514.3724655919772, 528.9973550132224, 532.292051571409, 532.5819231903015, 532.8934213157384, 10633.468326583485, 10737.194710396907, 10796.40619765889, 11059.72350691239, 11103.222774405715, 34843.0, 34928.476072859434, 35890.28219435649, 35912.82043589765, 36009.639903600626, 43033.0, 45889.54110458853, 47618.761906191634, 49153.75423123004, 49340.01319973508, 6725.327467253235, 6765.526413151032, 6831.419329357061, 6833.794986150423, 6840.794776156723, 12516.937415312865, 12716.872831271568, 12772.042096842959, 12837.229766214057, 12930.159539629894, 9220.170184683411, 9608.855867162138, 9765.316427849983, 11013.229073965065, 11132.55469781232, 10470.319429237075, 10697.358158510515, 10823.837642435527, 10850.29473084247, 10871.130309575374, 11187.10503159729, 11219.551217951517, 11423.85761423851, 11468.94265528667, 11596.362200079077, 5690.487856092972, 6780.288069752803, 6893.517453778188, 6907.551009184387, 6939.82650433723, 10947.781044379228, 11097.667069987914, 11282.492287846902, 11284.266522676, 11332.150088743541], "dojo.html": [3254.6419893811685, 3294.159989202753, 3329.350776598564, 3337.399268131737, 3356.2448449098947, 5317.627766056377, 5453.618246722731, 5470.91793623096, 5547.30658667666, 5562.110062390018, 5420.1327787554, 5544.417836127209, 5557.083081291582, 5598.188262701906, 5610.4670056344685, 5024.849254522361, 5057.165567681328, 5102.489751024905, 5143.15138002231, 5175.146100893348, 4892.486288939664, 5118.4113826909825, 5134.537891589756, 5177.767000484969, 5207.557357624588, 4923.65534412593, 5037.5718063964605, 5059.038782631288, 5072.442031376546, 5086.872828179288, 5056.292119103328, 5057.039162559102, 5070.264811602334, 5086.440491545927, 5112.36095488064, 4955.578775804061, 5055.5702765265, 5064.088464076464, 5065.974670126626, 5072.594192464631, 5261.76322065508, 5338.039152952467, 5404.6486978346675, 5410.675359478444, 5423.810166644188, 6078.209832721762, 6096.512279017668, 6099.0, 6101.511879049665, 6106.4809491192855, 5756.8848623027725, 5911.467967882868, 6083.148359229712, 6084.421979911901, 6089.3910608939195, 5493.615446918718, 5588.6646801192055, 5593.272874526367, 5600.747966341524, 5618.494335509783, 6140.785072522441, 6142.938570614326, 6144.38556144382, 6148.907766383508, 6158.630482170995, 5760.07838745807, 5840.211571437886, 5936.495397891142, 5950.306550500144, 5982.012967860342, 6092.791487165245, 6101.482626480511, 6102.786919474606, 6104.489471593237, 6106.855039299537, 6065.484433823086, 6067.211262535842, 6072.301685306158, 6090.299615544181, 6099.963006288942, 5833.912491312633, 5902.05567109269, 6024.548158888101, 6081.027035674271, 6081.179040829431, 4552.271636538138, 4555.840545580889, 4574.130915126116, 4582.610478109332, 4589.288660257599, 4059.3707975263883, 4064.634182923492, 4074.103697186614, 4081.387791831249, 4102.938455923164, 5469.863253418696, 5514.476124768141, 5560.7219639018695, 5583.05088135018, 5607.747651355618, 5963.284405871236, 6061.0, 6071.908921366183, 6086.665233412116, 6088.786892458743, 5440.183972404171, 5650.74571644277, 5660.29246344207, 5675.971620141955, 5677.489025987681, 5106.897862042812, 5194.506521880416, 5237.031149237403, 5242.239875218072, 5276.604254680914, 6346.2384513857705, 6368.522360822864, 6371.968140159455, 6376.043593460925, 6381.840453988594, 5685.914711279252, 5814.30228372598, 6107.664078475549, 6134.9079763804475, 6139.26328840542, 6110.358412366638, 6205.844853878689, 6208.472279856082, 6208.81373558794, 6212.192414986023, 5902.822915312548, 5977.162213844849, 5989.371116032754, 5993.70031498432, 6026.90959635597, 5919.200907877554, 6004.969975150097, 6073.30157031947, 6093.055576385667, 6107.816765497042, 5897.439743224387, 5902.498287645598, 5918.704064796829, 5919.052951527735, 5940.28716553999, 5861.9413805861395, 5905.675187864536, 5911.113332999912, 5914.763409463745, 5917.112433135064, 5594.13290939905, 5692.800751973661, 5772.826815195551, 5789.247397838422, 5904.439078287728, 5983.431574000463, 5995.940040599713, 5999.610025348338, 6050.062240352752, 6051.546134039877, 5837.532997360286, 5855.912161317498, 5858.648481091148, 5868.383819699041, 5869.501092407193], "mootools.html": [1324.496691257322, 1656.7100757367461, 1678.3789997700853, 1703.3952946703928, 1709.726443768997, 6357.61854288743, 6887.207971083327, 7066.929330706691, 7075.858482830353, 7077.716891324348, 7213.170485394181, 7333.083364579427, 7354.6322683865865, 7357.595332256724, 7377.631118444083, 1908.5419499320203, 1929.68160253558, 2115.4499830044224, 2125.904334304952, 2154.892255387232, 2218.92233771818, 2223.4219103033247, 2226.365485836537, 2227.142550118208, 2227.922022729205, 2158.5251244726214, 2213.1589995801573, 2213.690083388327, 2216.3018649125556, 2218.67829164771, 1881.6236752649525, 1906.1136571494253, 2104.9684254736267, 2136.487243061654, 2141.314779270634, 2168.533765240481, 2179.6730490426403, 2202.9559408811892, 2207.0509680837235, 2235.429965358839, 7428.480006399554, 7490.138634057099, 7493.550386976799, 7502.399808015346, 7503.024606801081, 4421.093675796454, 4500.752458614775, 4537.0, 4546.204414227497, 4547.431571053618, 2903.4483448144997, 2948.3366242595457, 2969.049904030711, 2985.149232468758, 3047.5733397324393, 848.0586548930683, 854.248261529856, 870.8301881133182, 946.9384490008127, 1878.286251224526, 10014.749631259205, 10095.39427634337, 10099.29304948654, 10111.241656875764, 10132.594696212143, 3929.390944403622, 4014.5985401460202, 4064.7357921734992, 4085.652719518874, 4095.180963807191, 8053.355731541463, 8090.271875531231, 8097.433179677484, 8099.959500202579, 8119.0, 4428.6678499112695, 4443.6667249955735, 4467.0, 4484.304932735431, 4491.146682130385, 4041.959580404217, 4054.8175332109536, 4080.9795951020055, 4088.591140885947, 4089.9795501022304, 3281.622613399442, 3308.1894935740415, 3337.748344370861, 3341.7159541438764, 3342.9498557521656, 1011.5094179323022, 1018.6027449294781, 1022.9232807539464, 1034.110664828247, 1034.5086084110137, 1023.1201166996377, 1031.9535620897077, 1032.6540608895955, 1157.242006485753, 1309.8559158492558, 6882.070920425778, 6974.058502102152, 6984.266652001466, 6988.301169883072, 7013.6142512161305, 477.80887644941606, 478.58124141376294, 486.4454521845099, 487.4954422173034, 491.0841281010889, 5521.641093328921, 5579.6652200868075, 5580.720963951786, 5581.720913954286, 5584.692841893653, 8768.167024132697, 8893.110688931056, 9067.863982040275, 9069.0, 9165.450072995642, 8946.239569636653, 9068.909310906938, 9107.544622768835, 9156.221721153643, 9171.44971301724, 6888.965555172192, 7017.859642807115, 7076.504644674927, 7127.358537731629, 7134.892976605355, 6731.562448440835, 6789.966050169717, 6805.421539169028, 6810.5913645181445, 6827.897581536182, 7593.126790419173, 7859.371250299848, 7926.881096783438, 7932.0878099017045, 8025.0, 7990.121086680577, 8160.591970401575, 8190.221928916743, 8332.583370831555, 8338.749837504885, 6337.746490140527, 6368.64972426521, 6380.393862583047, 6445.097686323825, 6461.61230326182, 7243.130824301117, 7315.63421828917, 7330.010448589373, 7333.230010848784, 7343.889841652486, 6794.150731158606, 6944.861102777815, 6961.6519174042105, 7020.719171233298, 7036.577805331696, 5742.799002034909, 5769.96140694679, 5819.185314055951, 6646.268910419753, 6716.992451132369, 6802.217744959393, 6846.281140480178, 6850.554713943578, 6851.212110607344, 6855.314468553105, 6068.453839154321, 6136.2636483622255, 6161.353057928853, 6224.346443623354, 6239.875202496016, 6274.403931626488, 6318.178636777373, 6318.778842740482, 6330.778422755181, 6340.461060809883], "ext.html": [555.2839964805943, 583.9795607153749, 590.2680675961806, 594.2927915780219, 594.8512871782054, 38748.612513874854, 39440.80279598602, 39601.0, 39615.405768913486, 39623.60376396239, 42372.364414533804, 42805.14389712204, 42956.140877182515, 42967.57032429675, 43089.0, 7548.8112797179965, 7696.615169241543, 8577.099404562525, 8780.824383512327, 9901.851472227921, 10048.94975525125, 10177.694669159937, 10200.438975856325, 10205.03052210039, 10207.438590877498, 10230.744231394237, 10358.844617330746, 10375.792484150312, 10386.27296089274, 10386.428746418944, 7828.569428681449, 8051.838963220762, 10053.296269261155, 10246.846297305547, 10286.228532860065, 9785.168260697848, 9859.30984831062, 9913.058259465339, 9919.206463482904, 9919.702408927744, 39129.60870391288, 39578.60421395778, 39601.60398396008, 39606.405903911465, 39703.404448933, 3370.4438767603315, 3472.774269672463, 3567.5362202913457, 3657.7929283336703, 3787.4129509926006, 30229.395412091853, 30547.847260763778, 30617.693823061705, 30711.692883071108, 30771.384572308427, 3513.5959364672876, 3589.3180295743723, 3608.206194637202, 3642.3807952648112, 3695.61196074411, 281691.0, 282280.0, 282631.0, 283136.0, 283939.0, 55041.0, 55776.72111639497, 55885.0, 57006.429935700944, 57485.0, 57608.423915761145, 57625.42374576285, 57802.0, 58114.12828807571, 58244.417555824744, 14408.20754858493, 14683.972121951574, 14687.853121468863, 14708.117512949044, 14736.778948315783, 10806.297590656583, 10850.131989440984, 10880.67357979262, 10882.075023623082, 10894.564217431373, 18928.62142757165, 19000.61998760017, 19137.808621913882, 19166.329178478685, 19201.423957281302, 7158.642067896584, 7319.451041171933, 7417.703291868264, 7457.179710231871, 7468.178500364956, 925.1303774451993, 979.8873129590188, 1033.1682995188944, 1057.5505410200633, 1070.0690399352457, 28605.14184574466, 28903.132906012852, 28917.855410723234, 29228.0, 29304.853475732485, 989.3717489394287, 998.336106489191, 999.2405771613626, 1099.0438318662814, 1115.1803424482998, 13515.86484135146, 13641.75327069279, 13726.313684315744, 13858.307084645727, 13870.237136957363, 324270.0, 328828.0, 330631.0, 331929.0, 332163.0, 46250.768746156056, 46400.5359946403, 46440.767796160806, 46487.30269045967, 46524.767376162905, 1348.6426097084282, 1352.1481466676128, 1370.2600595678223, 1370.9040367174402, 1373.0937581196563, 23186.420339491648, 27925.301867453476, 28429.147125586267, 28821.855890720413, 28952.0, 47057.2941405886, 48612.5138748608, 48634.0, 48663.513364865896, 48761.2685809706, 274159.0, 275888.0, 276936.0, 276947.0, 277385.0, 28096.0, 28462.57306140368, 31168.844155779076, 31235.219119522193, 31940.68059319377, 42150.15699685928, 42398.0, 42610.0, 43096.0, 43502.782486087366, 35885.0, 35997.82001089978, 36100.81949590235, 36983.815080924425, 37156.62843371532, 35837.283254334245, 36025.81987090048, 36424.63575364213, 36627.816860915525, 36637.63362366342, 35909.204539772385, 35916.4612530807, 36074.09814754652, 36334.8183259082, 36353.636463635026, 31636.841815790773, 32588.185295367806, 32597.511037333985, 32701.509477358333, 32882.34235315328, 24802.131925382524, 24968.500629986935, 25030.37424064413, 25118.623220651338, 25348.74651253464], "prototype.html": [323.6262117254571, 325.3622899117731, 325.9902202933912, 328.3171004311033, 333.2368875275619, 6082.543809214305, 6127.816165515031, 6138.079288106786, 6146.108814221935, 6176.2279715035675, 5999.760009599621, 6028.69856507174, 6033.426824451681, 6044.818655440333, 6045.486133678643, 4600.7239565626005, 4611.677182597203, 4612.377329060568, 4612.815487380501, 4613.100445413146, 4347.978260108695, 4449.688521803475, 4459.197344477992, 4466.665000125004, 4611.5619016193405, 4429.712068715539, 4433.024734558408, 4438.800253988562, 4439.378487011821, 4446.844360447385, 4275.828966841323, 4356.128774245164, 4443.644508439334, 4446.3108218226225, 4451.888702782424, 3725.3108174987715, 3732.925341493155, 3733.290674771785, 3737.495438115847, 3815.389537673959, 5688.947544704201, 5691.0, 5707.800226992035, 5738.311402631669, 5744.22452968848, 5254.553362964152, 5262.342207224097, 5277.076511610491, 5279.551238144724, 5288.814891478818, 5977.0, 6095.664738439384, 6305.905411418832, 6366.745330186787, 6439.903401448982, 4231.767252801094, 4232.153569286155, 4233.068724880522, 4239.0674051708575, 4249.405083288342, 6594.736210551572, 6610.7355705771715, 6677.298883617247, 6682.097916781221, 6693.799186024378, 4406.0, 4416.006398560298, 4425.0, 4426.44669416323, 4431.82272709088, 4377.715448495837, 4423.225935461282, 4443.977780111079, 4451.933221001687, 4462.308342206963, 5233.0, 5239.973800130975, 5240.3973543042275, 5247.580193584504, 5248.6325957182635, 6477.481801455872, 6479.514036447285, 6485.643289619116, 6492.188476440445, 6492.870142597121, 1539.076554067573, 1541.3295216580823, 1542.2674229741008, 1545.7526795712631, 1547.1104115133844, 1022.156720705421, 1024.2778840917285, 1028.3161697471248, 1050.0, 1051.9474026298653, 6194.473469755031, 6196.287426945869, 6202.968985155136, 6203.844903877439, 6208.50331973441, 6651.467882569383, 6658.167729033871, 6662.6668666566475, 6671.166104236971, 6679.0, 6024.789132380346, 6175.0, 6199.5660303779205, 6199.752009919553, 6209.9068513972325, 3507.5089487471773, 3602.495650608917, 3626.292872889814, 3628.7822730636244, 3630.146915474861, 6797.0, 6875.828104297332, 6904.482163837632, 6912.930870691329, 7028.50800443964, 6795.150606174228, 6798.422134118557, 6805.795826125224, 6816.352446517573, 6824.863502729918, 6790.083338749305, 6944.375006249563, 6964.164300283897, 6972.267911869282, 6976.302369762983, 6667.899981500184, 6699.866002680016, 6715.093462382712, 6719.193696756421, 6731.562448440835, 6646.468282537482, 6649.368310010541, 6650.767223147167, 6652.667366631552, 6654.234763002317, 6815.045893574805, 6975.128108986377, 6976.372126508639, 6979.267176946348, 6986.126734158231, 4444.022315090675, 4445.799939002817, 4446.9777651111535, 4448.088141930961, 4450.087732014865, 6671.432928200963, 6682.2649508555, 6682.431993280431, 6691.330866913269, 6692.899606505809, 6371.776987805404, 6506.837329066811, 6508.0, 6522.934770652233, 6528.477721782151, 6521.8695626088165, 6523.706433210422, 6526.216853977553, 6526.988316810902, 6530.118434011348, 6411.102445657705, 6413.7113829876835, 6414.679266036586, 6422.454091402096, 6431.163948686641, 6403.455706265019, 6545.280019197789, 6554.410103090554, 6556.147700799056, 6564.245111812203, 6398.584092034003, 6400.071989561395, 6400.103985442135, 6402.87194256103, 6406.13517175194], "yui.html": [753.4688044928323, 755.4070055006821, 757.4394947738673, 773.7910764093691, 809.1706001348617, 14088.788668169986, 14196.148231106115, 14232.288385580718, 14263.0, 14264.0, 13408.854583266679, 13505.122167059135, 13507.459701611924, 13534.864651353484, 13546.796798048012, 668.7559040950042, 684.9452043836482, 805.5126648377735, 806.5322113174345, 820.7660816667251, 817.2930415190876, 820.7742870710573, 825.1995564302617, 827.4166712467696, 827.668932427031, 864.7535452396069, 868.9217970382664, 871.0723079919896, 871.172386233078, 871.2246100970142, 712.5831388637653, 720.5352547606791, 854.8632218844986, 858.1118542308743, 868.3183700794846, 637.3117033603697, 637.4963778614889, 638.7445021991194, 639.1243995725886, 639.1371648274838, 13464.259465729381, 13538.120022198525, 13547.661308467268, 13555.390007449689, 13593.796093058612, 12107.213031152947, 12260.570880019157, 12269.815952760715, 12507.874921250763, 12939.611811645571, 10025.799484010351, 10521.105706014998, 10564.577416903314, 10679.572817087308, 10725.678229653124, 3655.5430571178604, 3668.1196512836996, 3676.8161591920566, 3690.612485689018, 3812.1803812180515, 47668.28497572539, 47717.52282477166, 47878.28182577264, 48211.0, 49034.75482622635, 9428.90571094294, 9430.811383772287, 9466.432014079039, 9504.287178461644, 9543.379680320757, 18103.81896181021, 18106.366277180234, 18194.54513637143, 18277.54306142357, 18295.176717047765, 7926.286634202949, 8009.559474228973, 8027.0, 8079.5960201989665, 8272.255497005179, 4148.0, 4163.042500224965, 4305.892352691145, 4335.761533115646, 4354.499232588293, 3132.98433507831, 3141.1204862638497, 3141.2618034761813, 3141.340318533088, 3149.165471150147, 459.6644449551846, 468.8780916961546, 472.9810807567659, 474.3146153807784, 487.84145152825477, 657.2901266632026, 665.5574043261178, 665.7836203233968, 675.8310422394402, 698.0541366448491, 7719.382449404035, 8420.957895210484, 8606.741797746077, 8717.433366831136, 8900.46597204157, 529.1929807044212, 698.828786947191, 709.9041629380071, 710.2010238481708, 716.7240612364277, 3728.2729867676085, 3864.9613503864603, 3914.5106861642294, 3930.744501607386, 3960.0, 51674.74162629163, 52137.0, 52171.47828521742, 57577.13634295489, 57604.0, 46422.07155856932, 46628.76685616618, 47116.293255601195, 47670.5232947673, 50759.49240507548, 45650.31524527201, 45972.310415343796, 46029.30956035662, 46195.76902115468, 47052.76473617678, 8218.917810821815, 8400.243978042006, 8422.199891010345, 8438.704645337384, 8484.151584841713, 34525.827370862986, 35250.64749352474, 35337.46993795044, 35515.644843551236, 36280.27439451249, 41372.58627413688, 43923.56076439195, 44700.77649611731, 44808.0, 44863.32705009362, 7986.880196796937, 8013.559254241072, 8196.795080123045, 8341.45780524264, 8385.245327920273, 12233.449494772934, 12326.137170397986, 12543.686407839878, 12676.049296303, 12777.425015874122, 10577.206709496972, 10629.574817007233, 10978.12175026012, 11057.0, 11478.540858365906, 10604.787904241717, 10801.24391292602, 10843.0, 10866.18503612248, 11209.831852522382, 7894.0, 10498.737531561466, 10987.725306867393, 11036.779264414827, 11196.720081998015, 9494.0, 9530.475823829756, 9753.317267791186, 9877.160441362565, 10204.38773673582, 9117.36178467501, 9301.813963720553, 9344.579493922654, 9375.578098985425, 9552.283578731483]}, "summary": {"lowerIsBetter": false, "suite": 6705.443792448676, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7167.039800007547, "unit": "ms", "value": 7167.039800007547}, "dojo.html": {"lowerIsBetter": false, "filtered": 5531.956158061183, "unit": "ms", "value": 5531.956158061183}, "mootools.html": {"lowerIsBetter": false, "filtered": 4178.612611843505, "unit": "ms", "value": 4178.612611843505}, "ext.html": {"lowerIsBetter": false, "filtered": 18504.949828264776, "unit": "ms", "value": 18504.949828264776}, "prototype.html": {"lowerIsBetter": false, "filtered": 4794.663801711712, "unit": "ms", "value": 4794.663801711712}, "yui.html": {"lowerIsBetter": false, "filtered": 6183.433963215566, "unit": "ms", "value": 6183.433963215566}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-021"}, "testrun": {"date": 1447451185, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151113113033", "branch": "Fx-Team", "revision": "8f4312027a498f6c89e23ab42fc3d161b2df66f0"}}, {"talos_counters": {}, "results": {"audio-dft": [175.0, 172.0, 172.0, 171.0, 170.0, 171.0, 169.0, 171.0, 171.0, 169.0], "ai-astar": [107.0, 109.0, 104.0, 109.0, 110.0, 112.0, 100.0, 109.0, 109.0, 107.0], "imaging-gaussian-blur": [109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "audio-beat-detection": [154.0, 130.0, 145.0, 170.0, 124.0, 157.0, 148.0, 125.0, 160.0, 125.0], "json-stringify-tinderbox": [67.0, 67.0, 67.0, 66.0, 66.0, 66.0, 67.0, 68.0, 66.0, 67.0], "stanford-crypto-pbkdf2": [153.0, 147.0, 144.0, 141.0, 147.0, 140.0, 151.0, 154.0, 154.0, 144.0], "json-parse-financial": [57.0, 57.0, 56.0, 56.0, 56.0, 56.0, 57.0, 65.0, 54.0, 55.0], "stanford-crypto-sha256-iterative": [68.0, 67.0, 66.0, 66.0, 66.0, 66.0, 68.0, 66.0, 68.0, 66.0], "audio-fft": [72.0, 71.0, 72.0, 92.0, 72.0, 72.0, 72.0, 94.0, 90.0, 71.0], "imaging-darkroom": [144.0, 145.0, 144.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0], "stanford-crypto-ccm": [123.0, 116.0, 124.0, 119.0, 115.0, 122.0, 126.0, 133.0, 116.0, 121.0], "audio-oscillator": [90.0, 91.0, 136.0, 91.0, 91.0, 90.0, 138.0, 90.0, 91.0, 137.0], "stanford-crypto-aes": [85.0, 85.0, 85.0, 84.0, 84.0, 83.0, 83.0, 84.0, 84.0, 92.0], "imaging-desaturate": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1498.4, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 77.8, "unit": "ms", "value": 77.8}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 147.5, "unit": "ms", "value": 147.5}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 143.8, "unit": "ms", "value": 143.8}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 121.5, "unit": "ms", "value": 121.5}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.0, "unit": "ms", "value": 145.0}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 56.9, "unit": "ms", "value": 56.9}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 104.5, "unit": "ms", "value": 104.5}, "ai-astar": {"lowerIsBetter": true, "filtered": 107.6, "unit": "ms", "value": 107.6}, "audio-dft": {"lowerIsBetter": true, "filtered": 171.1, "unit": "ms", "value": 171.1}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 66.7, "unit": "ms", "value": 66.7}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 66.7, "unit": "ms", "value": 66.7}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.2, "unit": "ms", "value": 109.2}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 84.9, "unit": "ms", "value": 84.9}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.2, "unit": "ms", "value": 95.2}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-021"}, "testrun": {"date": 1447451185, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151113113033", "branch": "Fx-Team", "revision": "8f4312027a498f6c89e23ab42fc3d161b2df66f0"}}, {"talos_counters": {}, "results": {"DeltaBlue": [194.21246844047388], "Encrypt": [281.7695125387433], "NavierStokes": [4830.917874396136], "Decrypt": [5035.175879396985], "Splay": [622.66500622665], "Richards": [170.06802721088437], "RegExp": [27432.432432432433], "Earley": [784.9293563579278], "Boyer": [12060.240963855422], "RayTrace": [1095.290251916758]}, "summary": {"lowerIsBetter": false, "suite": 20854.321189224884, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 340.441582, "unit": "score", "value": 340.441582}, "Encrypt": {"lowerIsBetter": false, "filtered": 944.6763689999997, "unit": "score", "value": 944.6763689999997}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.1879999999999, "unit": "score", "value": 307.1879999999999}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.864290419161705, "unit": "score", "value": 52.864290419161705}, "Splay": {"lowerIsBetter": false, "filtered": 130.874546, "unit": "score", "value": 130.874546}, "RegExp": {"lowerIsBetter": false, "filtered": 33.208320197044344, "unit": "score", "value": 33.208320197044344}, "Richards": {"lowerIsBetter": false, "filtered": 207.57575999999992, "unit": "score", "value": 207.57575999999992}, "Earley": {"lowerIsBetter": false, "filtered": 849.0738620000004, "unit": "score", "value": 849.0738620000004}, "Boyer": {"lowerIsBetter": false, "filtered": 55.2611678321678, "unit": "score", "value": 55.2611678321678}, "RayTrace": {"lowerIsBetter": false, "filtered": 675.6099569999998, "unit": "score", "value": 675.6099569999998}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-021"}, "testrun": {"date": 1447451185, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151113113033", "branch": "Fx-Team", "revision": "8f4312027a498f6c89e23ab42fc3d161b2df66f0"}}] 14:06:41 INFO - RETURN: dromaeo_css: 6705.44 14:06:41 INFO - RETURN: kraken: 1498.40 14:06:41 INFO - RETURN: v8_7: 20854.32 14:06:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20854.32"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1498.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6705.44"}}} 14:06:41 INFO - Return code: 0 14:06:41 INFO - # TBPL SUCCESS # 14:06:41 INFO - Running post-action listener: _resource_record_post_action 14:06:41 INFO - Running post-run listener: _resource_record_post_run 14:06:42 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 430080; Write bytes: 278142976; Read time: 128; Write time: 516008 14:06:42 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9265152; Read time: 0; Write time: 1388 14:06:42 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 425984; Write bytes: 268877824; Read time: 128; Write time: 514620 14:06:42 INFO - Running post-run listener: _upload_blobber_files 14:06:42 INFO - Blob upload gear active. 14:06:42 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:06:42 INFO - Copying logs to upload dir... 14:06:42 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1278.537189 ========= master_lag: 38.99 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2015-11-13 14:07:21.960443) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-13 14:07:21.963643) ========= 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=ccb4611811c763f2fad71465000001de-1447450787.366734-23142978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009958 build_url: 'https://queue.taskcluster.net/v1/task/k8sEsjeZRz6cti38h_3qTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.52 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-13 14:07:22.495336) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 14:07:22.495705) ========= 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=ccb4611811c763f2fad71465000001de-1447450787.366734-23142978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003253 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 14:07:22.542598) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 14:07:22.542928) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 14:07:22.546282) ========= ========= Total master_lag: 39.66 =========