builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-024 starttime: 1448321545.7 results: success (0) buildid: 20151123143012 builduid: 85c642d7a518489d8e97a9f5abec6004 revision: 18d63333b155fdcd07be32ae90336b304e232daa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 15:32:25.696419) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 15:32:25.697218) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 15:32:25.697577) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1448318115.326639-59100879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006367 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 15:32:25.718912) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 15:32:25.719280) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 15:32:25.761861) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:32:25.762256) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1448318115.326639-59100879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004626 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:32:25.811775) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 15:32:25.812089) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 15:32:25.812492) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:32:25.812815) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1448318115.326639-59100879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 15:32:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 25.3M=0s 2015-11-23 15:32:26 (25.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181553 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:32:26.008148) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:32:26.008533) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1448318115.326639-59100879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022377 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:32:26.057860) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:32:26.058240) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 18d63333b155fdcd07be32ae90336b304e232daa --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/b2g-inbound --rev 18d63333b155fdcd07be32ae90336b304e232daa --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=5400c60ebd4f8d7cf28c0934000001b8-1448318115.326639-59100879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 15:32:26,944 truncating revision to first 12 chars 2015-11-23 15:32:26,944 Setting DEBUG logging. 2015-11-23 15:32:26,944 attempt 1/10 2015-11-23 15:32:26,944 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/18d63333b155?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 15:32:27,337 unpacking tar archive at: b2g-inbound-18d63333b155/testing/mozharness/ program finished with exit code 0 elapsedTime=0.662202 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:32:26.737497) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 15:32:26.738257) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 15:32:26.747857) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 15:32:26.748172) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 15:32:26.748607) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2015-11-23 15:32:26.748956) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5400c60ebd4f8d7cf28c0934000001b8-1448318115.326639-59100879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:32:27 INFO - MultiFileLogger online at 20151123 15:32:27 in /builds/slave/test-pgo 15:32:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 15:32:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:32:27 INFO - {'append_to_log': False, 15:32:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:32:27 INFO - 'blob_upload_branch': 'B2G-Inbound', 15:32:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:32:27 INFO - 'branch': 'B2G-Inbound', 15:32:27 INFO - 'buildbot_json_path': 'buildprops.json', 15:32:27 INFO - 'config_files': ('talos/linux_config.py',), 15:32:27 INFO - 'default_actions': ('clobber', 15:32:27 INFO - 'read-buildbot-config', 15:32:27 INFO - 'download-and-extract', 15:32:27 INFO - 'populate-webroot', 15:32:27 INFO - 'create-virtualenv', 15:32:27 INFO - 'install', 15:32:27 INFO - 'run-tests'), 15:32:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:32:27 INFO - 'download_minidump_stackwalk': True, 15:32:27 INFO - 'download_symbols': 'ondemand', 15:32:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:32:27 INFO - 'tooltool.py': '/tools/tooltool.py', 15:32:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:32:27 INFO - '/tools/misc-python/virtualenv.py')}, 15:32:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:32:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:32:27 INFO - 'installer_path': 'installer.exe', 15:32:27 INFO - 'log_level': 'info', 15:32:27 INFO - 'log_name': 'talos', 15:32:27 INFO - 'log_to_console': True, 15:32:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:32:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:32:27 INFO - 'opt_config_files': (), 15:32:27 INFO - 'pip_index': False, 15:32:27 INFO - 'sps_profile': False, 15:32:27 INFO - 'sps_profile_interval': 0, 15:32:27 INFO - 'suite': 'dromaeojs', 15:32:27 INFO - 'system_bits': '64', 15:32:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:32:27 INFO - 'title': 'talos-linux64-ix-024', 15:32:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:32:27 INFO - 'use_talos_json': True, 15:32:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:32:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:32:27 INFO - 'work_dir': 'build'} 15:32:27 INFO - ##### 15:32:27 INFO - ##### Running clobber step. 15:32:27 INFO - ##### 15:32:27 INFO - Running pre-action listener: _resource_record_pre_action 15:32:27 INFO - Running main action method: clobber 15:32:27 INFO - rmtree: /builds/slave/test-pgo/build 15:32:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:32:28 INFO - Running post-action listener: _resource_record_post_action 15:32:28 INFO - ##### 15:32:28 INFO - ##### Running read-buildbot-config step. 15:32:28 INFO - ##### 15:32:28 INFO - Running pre-action listener: _resource_record_pre_action 15:32:28 INFO - Running main action method: read_buildbot_config 15:32:28 INFO - Using buildbot properties: 15:32:28 INFO - { 15:32:28 INFO - "properties": { 15:32:28 INFO - "buildnumber": 51, 15:32:28 INFO - "product": "firefox", 15:32:28 INFO - "script_repo_revision": "production", 15:32:28 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 15:32:28 INFO - "repository": "", 15:32:28 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 15:32:28 INFO - "buildid": "20151123143012", 15:32:28 INFO - "slavename": "talos-linux64-ix-024", 15:32:28 INFO - "pgo_build": "True", 15:32:28 INFO - "basedir": "/builds/slave/test-pgo", 15:32:28 INFO - "project": "", 15:32:28 INFO - "platform": "ubuntu64_hw", 15:32:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:32:28 INFO - "slavebuilddir": "test", 15:32:28 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 15:32:28 INFO - "branch": "b2g-inbound", 15:32:28 INFO - "repo_path": "integration/b2g-inbound", 15:32:28 INFO - "stage_platform": "linux64-pgo", 15:32:28 INFO - "builduid": "85c642d7a518489d8e97a9f5abec6004", 15:32:28 INFO - "revision": "18d63333b155fdcd07be32ae90336b304e232daa" 15:32:28 INFO - }, 15:32:28 INFO - "sourcestamp": { 15:32:28 INFO - "repository": "", 15:32:28 INFO - "hasPatch": false, 15:32:28 INFO - "project": "", 15:32:28 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 15:32:28 INFO - "changes": [ 15:32:28 INFO - { 15:32:28 INFO - "category": null, 15:32:28 INFO - "files": [ 15:32:28 INFO - { 15:32:28 INFO - "url": null, 15:32:28 INFO - "name": "https://queue.taskcluster.net/v1/task/FTp9ZoacSoG0DVJxV0fHEA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 15:32:28 INFO - } 15:32:28 INFO - ], 15:32:28 INFO - "repository": "", 15:32:28 INFO - "rev": "18d63333b155fdcd07be32ae90336b304e232daa", 15:32:28 INFO - "who": "sendchange", 15:32:28 INFO - "when": 1448321479, 15:32:28 INFO - "number": 6697521, 15:32:28 INFO - "comments": "", 15:32:28 INFO - "project": "", 15:32:28 INFO - "at": "Mon 23 Nov 2015 15:31:19", 15:32:28 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 15:32:28 INFO - "revlink": "", 15:32:28 INFO - "properties": [ 15:32:28 INFO - [ 15:32:28 INFO - "buildid", 15:32:28 INFO - "20151123143012", 15:32:28 INFO - "Change" 15:32:28 INFO - ], 15:32:28 INFO - [ 15:32:28 INFO - "builduid", 15:32:28 INFO - "85c642d7a518489d8e97a9f5abec6004", 15:32:28 INFO - "Change" 15:32:28 INFO - ], 15:32:28 INFO - [ 15:32:28 INFO - "pgo_build", 15:32:28 INFO - "True", 15:32:28 INFO - "Change" 15:32:28 INFO - ] 15:32:28 INFO - ], 15:32:28 INFO - "revision": "18d63333b155fdcd07be32ae90336b304e232daa" 15:32:28 INFO - } 15:32:28 INFO - ], 15:32:28 INFO - "revision": "18d63333b155fdcd07be32ae90336b304e232daa" 15:32:28 INFO - } 15:32:28 INFO - } 15:32:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/FTp9ZoacSoG0DVJxV0fHEA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 15:32:28 INFO - Running post-action listener: _resource_record_post_action 15:32:28 INFO - ##### 15:32:28 INFO - ##### Running download-and-extract step. 15:32:28 INFO - ##### 15:32:28 INFO - Running pre-action listener: _resource_record_pre_action 15:32:28 INFO - Running main action method: download_and_extract 15:32:28 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:32:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:28 INFO - https://queue.taskcluster.net/v1/task/FTp9ZoacSoG0DVJxV0fHEA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:32:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FTp9ZoacSoG0DVJxV0fHEA/artifacts/public/build/test_packages.json 15:32:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FTp9ZoacSoG0DVJxV0fHEA/artifacts/public/build/test_packages.json 15:32:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FTp9ZoacSoG0DVJxV0fHEA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:32:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FTp9ZoacSoG0DVJxV0fHEA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 15:32:30 INFO - Downloaded 1302 bytes. 15:32:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:32:30 INFO - Using the following test package requirements: 15:32:30 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:32:30 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:32:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:32:30 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:32:30 INFO - u'jsshell-linux-x86_64.zip'], 15:32:30 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:32:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:32:30 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:32:30 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:32:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:32:30 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:32:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:32:30 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:32:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:32:30 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:32:30 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:32:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:32:30 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:32: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')]} 15:32:30 INFO - https://queue.taskcluster.net/v1/task/FTp9ZoacSoG0DVJxV0fHEA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:32:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FTp9ZoacSoG0DVJxV0fHEA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:32:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FTp9ZoacSoG0DVJxV0fHEA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:32:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FTp9ZoacSoG0DVJxV0fHEA/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 15:32:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FTp9ZoacSoG0DVJxV0fHEA/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 15:32:30 INFO - Downloaded 22526114 bytes. 15:32:30 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 15:32:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:32:30 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 15:32:32 INFO - Return code: 0 15:32:32 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 15:32:32 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')]} 15:32:32 INFO - https://queue.taskcluster.net/v1/task/FTp9ZoacSoG0DVJxV0fHEA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:32:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FTp9ZoacSoG0DVJxV0fHEA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:32:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FTp9ZoacSoG0DVJxV0fHEA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:32:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FTp9ZoacSoG0DVJxV0fHEA/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 15:32:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FTp9ZoacSoG0DVJxV0fHEA/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 15:32:33 INFO - Downloaded 22526114 bytes. 15:32:33 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 15:32:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:32:33 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 15:32:34 INFO - Return code: 0 15:32:34 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')]} 15:32:34 INFO - https://queue.taskcluster.net/v1/task/FTp9ZoacSoG0DVJxV0fHEA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:32:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FTp9ZoacSoG0DVJxV0fHEA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:32:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FTp9ZoacSoG0DVJxV0fHEA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:32:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FTp9ZoacSoG0DVJxV0fHEA/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 15:32:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FTp9ZoacSoG0DVJxV0fHEA/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 15:32:35 INFO - Downloaded 11130997 bytes. 15:32:35 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 15:32:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:32:35 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 15:32:36 INFO - Return code: 0 15:32:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:36 INFO - https://queue.taskcluster.net/v1/task/FTp9ZoacSoG0DVJxV0fHEA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:32:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FTp9ZoacSoG0DVJxV0fHEA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:32:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FTp9ZoacSoG0DVJxV0fHEA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:32:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FTp9ZoacSoG0DVJxV0fHEA/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 15:32:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FTp9ZoacSoG0DVJxV0fHEA/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 15:32:37 INFO - Downloaded 57557895 bytes. 15:32:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FTp9ZoacSoG0DVJxV0fHEA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:32:37 INFO - mkdir: /builds/slave/test-pgo/properties 15:32:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:32:37 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:32:37 INFO - Contents: 15:32:37 INFO - build_url:https://queue.taskcluster.net/v1/task/FTp9ZoacSoG0DVJxV0fHEA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:32:37 INFO - Running post-action listener: _resource_record_post_action 15:32:37 INFO - Running post-action listener: set_extra_try_arguments 15:32:37 INFO - ##### 15:32:37 INFO - ##### Running populate-webroot step. 15:32:37 INFO - ##### 15:32:37 INFO - Running pre-action listener: _resource_record_pre_action 15:32:37 INFO - Running main action method: populate_webroot 15:32:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:32:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:32:37 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:32:37 INFO - '../fennec_ids.txt'], 15:32:37 INFO - 'tests': ['tcheck2']}, 15:32:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:32:37 INFO - '--tppagecycles', 15:32:37 INFO - '7'], 15:32:37 INFO - 'tests': ['tsvgm']}}, 15:32:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:32:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:32:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:32:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:32:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:32:37 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:32:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:32:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:37 INFO - 'talos_options': ['--e10s'], 15:32:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:32:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:37 INFO - 'tests': ['damp', 'tps']}, 15:32:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:37 INFO - 'talos_options': ['--e10s'], 15:32:37 INFO - 'tests': ['damp', 'tps']}, 15:32:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:32:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:32:37 INFO - 'other': {'tests': ['a11yr', 15:32:37 INFO - 'ts_paint', 15:32:37 INFO - 'tpaint', 15:32:37 INFO - 'sessionrestore', 15:32:37 INFO - 'sessionrestore_no_auto_restore']}, 15:32:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:32:37 INFO - 'tests': ['a11yr', 15:32:37 INFO - 'ts_paint', 15:32:37 INFO - 'tpaint', 15:32:37 INFO - 'sessionrestore', 15:32:37 INFO - 'sessionrestore_no_auto_restore']}, 15:32:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:32:37 INFO - 'tests': ['a11yr', 15:32:37 INFO - 'ts_paint', 15:32:37 INFO - 'tpaint', 15:32:37 INFO - 'sessionrestore', 15:32:37 INFO - 'sessionrestore_no_auto_restore']}, 15:32:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:32:37 INFO - 'tests': ['a11yr', 15:32:37 INFO - 'ts_paint', 15:32:37 INFO - 'tpaint', 15:32:37 INFO - 'sessionrestore', 15:32:37 INFO - 'sessionrestore_no_auto_restore']}, 15:32:37 INFO - 'other_l64': {'tests': ['a11yr', 15:32:37 INFO - 'ts_paint', 15:32:37 INFO - 'tpaint', 15:32:37 INFO - 'sessionrestore', 15:32:37 INFO - 'sessionrestore_no_auto_restore']}, 15:32:37 INFO - 'other_nol64': {'tests': ['a11yr', 15:32:37 INFO - 'ts_paint', 15:32:37 INFO - 'tpaint', 15:32:37 INFO - 'sessionrestore', 15:32:37 INFO - 'sessionrestore_no_auto_restore']}, 15:32:37 INFO - 'svgr': {'tests': ['tsvgx', 15:32:37 INFO - 'tsvgr_opacity', 15:32:37 INFO - 'tart', 15:32:37 INFO - 'tscrollx', 15:32:37 INFO - 'cart']}, 15:32:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:32:37 INFO - 'tests': ['tsvgx', 15:32:37 INFO - 'tsvgr_opacity', 15:32:37 INFO - 'tart', 15:32:37 INFO - 'tscrollx', 15:32:37 INFO - 'cart']}, 15:32:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:37 INFO - 'tests': ['tp5o']}, 15:32:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:37 INFO - 'talos_options': ['--e10s'], 15:32:37 INFO - 'tests': ['tp5o']}, 15:32:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:37 INFO - 'talos_options': ['--xperf_path', 15:32:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:32:37 INFO - 'tests': ['tp5n']}, 15:32:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:37 INFO - 'talos_options': ['--e10s', 15:32:37 INFO - '--xperf_path', 15:32:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:32:37 INFO - 'tests': ['tp5n']}}, 15:32:37 INFO - 'talos.zip': {'path': '', 15:32:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:32:37 INFO - Running post-action listener: _resource_record_post_action 15:32:37 INFO - ##### 15:32:37 INFO - ##### Running create-virtualenv step. 15:32:37 INFO - ##### 15:32:37 INFO - Running pre-action listener: _resource_record_pre_action 15:32:37 INFO - Running main action method: create_virtualenv 15:32:37 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:32:37 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 15:32:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:32:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:32:38 INFO - Using real prefix '/usr' 15:32:38 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:32:38 INFO - Installing distribute.............................................................................................................................................................................................done. 15:32:40 INFO - Installing pip.................done. 15:32:40 INFO - Return code: 0 15:32:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:32:40 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')]} 15:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:40 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')]} 15:32:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:40 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 0x7fde6e9c4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12916c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13437c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1387d70>, '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 0x1388b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1388fb0>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1448318115.326639-59100879', '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 15:32:40 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 15:32:40 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 15:32:40 INFO - Using env: {'DISPLAY': ':0', 15:32:40 INFO - 'HOME': '/home/cltbld', 15:32:40 INFO - 'LANG': 'en_US.UTF-8', 15:32:40 INFO - 'LANGUAGE': 'en_US:en', 15:32:40 INFO - 'LOGNAME': 'cltbld', 15:32:40 INFO - 'MAIL': '/var/mail/cltbld', 15:32:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:40 INFO - 'MOZ_NO_REMOTE': '1', 15:32:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:40 INFO - 'NO_EM_RESTART': '1', 15:32:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:32:40 INFO - 'PWD': '/builds/slave/test-pgo', 15:32:40 INFO - 'SHELL': '/bin/bash', 15:32:40 INFO - 'SHLVL': '1', 15:32:40 INFO - 'TERM': 'linux', 15:32:40 INFO - 'TMOUT': '86400', 15:32:40 INFO - 'USER': 'cltbld', 15:32:40 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1448318115.326639-59100879', 15:32:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:40 INFO - '_': '/tools/buildbot/bin/python'} 15:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:40 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 15:32:40 INFO - Cleaning up... 15:32:40 INFO - Return code: 0 15:32:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:32:40 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')]} 15:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:40 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')]} 15:32:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:40 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 0x7fde6e9c4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12916c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13437c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1387d70>, '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 0x1388b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1388fb0>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1448318115.326639-59100879', '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 15:32:40 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 15:32:40 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 15:32:40 INFO - Using env: {'DISPLAY': ':0', 15:32:40 INFO - 'HOME': '/home/cltbld', 15:32:40 INFO - 'LANG': 'en_US.UTF-8', 15:32:40 INFO - 'LANGUAGE': 'en_US:en', 15:32:40 INFO - 'LOGNAME': 'cltbld', 15:32:40 INFO - 'MAIL': '/var/mail/cltbld', 15:32:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:40 INFO - 'MOZ_NO_REMOTE': '1', 15:32:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:40 INFO - 'NO_EM_RESTART': '1', 15:32:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:32:40 INFO - 'PWD': '/builds/slave/test-pgo', 15:32:40 INFO - 'SHELL': '/bin/bash', 15:32:40 INFO - 'SHLVL': '1', 15:32:40 INFO - 'TERM': 'linux', 15:32:40 INFO - 'TMOUT': '86400', 15:32:40 INFO - 'USER': 'cltbld', 15:32:40 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1448318115.326639-59100879', 15:32:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:40 INFO - '_': '/tools/buildbot/bin/python'} 15:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:40 INFO - Downloading/unpacking psutil>=0.7.1 15:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:42 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 15:32:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:32:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:32:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:32:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:32:42 INFO - Installing collected packages: psutil 15:32:42 INFO - Running setup.py install for psutil 15:32:42 INFO - building 'psutil._psutil_linux' extension 15:32:42 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 15:32:43 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 15:32:43 INFO - building 'psutil._psutil_posix' extension 15:32:43 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 15:32:43 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 15:32:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:32:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:32:43 INFO - Successfully installed psutil 15:32:43 INFO - Cleaning up... 15:32:43 INFO - Return code: 0 15:32:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:32:43 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')]} 15:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:43 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')]} 15:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:43 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 0x7fde6e9c4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12916c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13437c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1387d70>, '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 0x1388b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1388fb0>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1448318115.326639-59100879', '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 15:32:43 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 15:32:43 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 15:32:43 INFO - Using env: {'DISPLAY': ':0', 15:32:43 INFO - 'HOME': '/home/cltbld', 15:32:43 INFO - 'LANG': 'en_US.UTF-8', 15:32:43 INFO - 'LANGUAGE': 'en_US:en', 15:32:43 INFO - 'LOGNAME': 'cltbld', 15:32:43 INFO - 'MAIL': '/var/mail/cltbld', 15:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:43 INFO - 'MOZ_NO_REMOTE': '1', 15:32:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:43 INFO - 'NO_EM_RESTART': '1', 15:32:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:32:43 INFO - 'PWD': '/builds/slave/test-pgo', 15:32:43 INFO - 'SHELL': '/bin/bash', 15:32:43 INFO - 'SHLVL': '1', 15:32:43 INFO - 'TERM': 'linux', 15:32:43 INFO - 'TMOUT': '86400', 15:32:43 INFO - 'USER': 'cltbld', 15:32:43 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1448318115.326639-59100879', 15:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:43 INFO - '_': '/tools/buildbot/bin/python'} 15:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:32:43 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 15:32:43 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 15:32:43 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 15:32:43 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 15:32:43 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 15:32:43 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 15:32:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:32:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:32:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:32:45 INFO - Installing collected packages: mozsystemmonitor 15:32:45 INFO - Running setup.py install for mozsystemmonitor 15:32:45 INFO - Successfully installed mozsystemmonitor 15:32:45 INFO - Cleaning up... 15:32:45 INFO - Return code: 0 15:32:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:32: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')]} 15:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32: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')]} 15:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fde6e9c4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12916c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13437c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1387d70>, '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 0x1388b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1388fb0>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1448318115.326639-59100879', '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 15:32:45 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 15:32:45 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 15:32:45 INFO - Using env: {'DISPLAY': ':0', 15:32:45 INFO - 'HOME': '/home/cltbld', 15:32:45 INFO - 'LANG': 'en_US.UTF-8', 15:32:45 INFO - 'LANGUAGE': 'en_US:en', 15:32:45 INFO - 'LOGNAME': 'cltbld', 15:32:45 INFO - 'MAIL': '/var/mail/cltbld', 15:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:45 INFO - 'MOZ_NO_REMOTE': '1', 15:32:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:45 INFO - 'NO_EM_RESTART': '1', 15:32:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:32:45 INFO - 'PWD': '/builds/slave/test-pgo', 15:32:45 INFO - 'SHELL': '/bin/bash', 15:32:45 INFO - 'SHLVL': '1', 15:32:45 INFO - 'TERM': 'linux', 15:32:45 INFO - 'TMOUT': '86400', 15:32:45 INFO - 'USER': 'cltbld', 15:32:45 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1448318115.326639-59100879', 15:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:45 INFO - '_': '/tools/buildbot/bin/python'} 15:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:45 INFO - Downloading/unpacking blobuploader==1.2.4 15:32:45 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 15:32:45 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 15:32:45 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 15:32:45 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 15:32:45 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 15:32:45 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 15:32:47 INFO - Downloading blobuploader-1.2.4.tar.gz 15:32:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:32:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:32:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:32:47 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 15:32:47 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 15:32:47 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 15:32:47 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 15:32:47 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 15:32:47 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 15:32:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:32:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:32:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:32:47 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 15:32:47 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 15:32:47 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 15:32:47 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 15:32:47 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 15:32:47 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 15:32:47 INFO - Downloading docopt-0.6.1.tar.gz 15:32:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:32:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:32:48 INFO - Installing collected packages: blobuploader, requests, docopt 15:32:48 INFO - Running setup.py install for blobuploader 15:32:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:32:48 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:32:48 INFO - Running setup.py install for requests 15:32:48 INFO - Running setup.py install for docopt 15:32:48 INFO - Successfully installed blobuploader requests docopt 15:32:48 INFO - Cleaning up... 15:32:48 INFO - Return code: 0 15:32:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:48 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 0x7fde6e9c4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12916c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13437c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1387d70>, '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 0x1388b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1388fb0>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1448318115.326639-59100879', '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 15:32:48 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 15:32:48 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 15:32:48 INFO - Using env: {'DISPLAY': ':0', 15:32:48 INFO - 'HOME': '/home/cltbld', 15:32:48 INFO - 'LANG': 'en_US.UTF-8', 15:32:48 INFO - 'LANGUAGE': 'en_US:en', 15:32:48 INFO - 'LOGNAME': 'cltbld', 15:32:48 INFO - 'MAIL': '/var/mail/cltbld', 15:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:48 INFO - 'MOZ_NO_REMOTE': '1', 15:32:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:48 INFO - 'NO_EM_RESTART': '1', 15:32:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:32:48 INFO - 'PWD': '/builds/slave/test-pgo', 15:32:48 INFO - 'SHELL': '/bin/bash', 15:32:48 INFO - 'SHLVL': '1', 15:32:48 INFO - 'TERM': 'linux', 15:32:48 INFO - 'TMOUT': '86400', 15:32:48 INFO - 'USER': 'cltbld', 15:32:48 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1448318115.326639-59100879', 15:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:48 INFO - '_': '/tools/buildbot/bin/python'} 15:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:32:48 INFO - Running setup.py (path:/tmp/pip-3dxXia-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:32:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:32:48 INFO - Running setup.py (path:/tmp/pip-TZWiWk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:32:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:32:49 INFO - Running setup.py (path:/tmp/pip-oEnKCO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:32:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:32:49 INFO - Running setup.py (path:/tmp/pip-xcYNmo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:32:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:32:49 INFO - Running setup.py (path:/tmp/pip-aM4qRS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:32:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:32:49 INFO - Running setup.py (path:/tmp/pip-0pS8tj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:32:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:32:49 INFO - Running setup.py (path:/tmp/pip-1uWV8Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:32:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:32:49 INFO - Running setup.py (path:/tmp/pip-Ny4s1D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:32:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:32:49 INFO - Running setup.py (path:/tmp/pip-D6EvtO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:32:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:32:49 INFO - Running setup.py (path:/tmp/pip-PUjhRb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:32:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:32:49 INFO - Running setup.py (path:/tmp/pip-6uu6By-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:32:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:32:49 INFO - Running setup.py (path:/tmp/pip-LEpwIt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:32:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:32:49 INFO - Running setup.py (path:/tmp/pip-25p5JT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:32:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:32:49 INFO - Running setup.py (path:/tmp/pip-jAIyS9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:32:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:32:49 INFO - Running setup.py (path:/tmp/pip-_ucCMP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:32:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:32:49 INFO - Running setup.py (path:/tmp/pip-X2jWqQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:32:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:32:50 INFO - Running setup.py (path:/tmp/pip-yegEUy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:32:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:32:50 INFO - Running setup.py install for manifestparser 15:32:50 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:32:50 INFO - Running setup.py install for mozcrash 15:32:50 INFO - Running setup.py install for mozdebug 15:32:50 INFO - Running setup.py install for mozdevice 15:32:50 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:32:50 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:32:50 INFO - Running setup.py install for mozfile 15:32:50 INFO - Running setup.py install for mozhttpd 15:32:50 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:32:50 INFO - Running setup.py install for mozinfo 15:32:50 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:32:50 INFO - Running setup.py install for mozInstall 15:32:50 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:32:50 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:32:50 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:32:50 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:32:50 INFO - Running setup.py install for mozleak 15:32:51 INFO - Running setup.py install for mozlog 15:32:51 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:32:51 INFO - Running setup.py install for moznetwork 15:32:51 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:32:51 INFO - Running setup.py install for mozprocess 15:32:51 INFO - Running setup.py install for mozprofile 15:32:51 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:32:51 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:32:51 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:32:51 INFO - Running setup.py install for mozrunner 15:32:51 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:32:51 INFO - Running setup.py install for mozscreenshot 15:32:51 INFO - Running setup.py install for moztest 15:32:51 INFO - Running setup.py install for mozversion 15:32:51 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:32:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:32:51 INFO - Cleaning up... 15:32:51 INFO - Return code: 0 15:32:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:32: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')]} 15:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32: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')]} 15:32:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32: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', '-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 0x7fde6e9c4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12916c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13437c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1387d70>, '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 0x1388b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1388fb0>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1448318115.326639-59100879', '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 15:32:51 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 15:32:51 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 15:32:51 INFO - Using env: {'DISPLAY': ':0', 15:32:51 INFO - 'HOME': '/home/cltbld', 15:32:51 INFO - 'LANG': 'en_US.UTF-8', 15:32:51 INFO - 'LANGUAGE': 'en_US:en', 15:32:51 INFO - 'LOGNAME': 'cltbld', 15:32:51 INFO - 'MAIL': '/var/mail/cltbld', 15:32:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:51 INFO - 'MOZ_NO_REMOTE': '1', 15:32:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:51 INFO - 'NO_EM_RESTART': '1', 15:32:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:32:51 INFO - 'PWD': '/builds/slave/test-pgo', 15:32:51 INFO - 'SHELL': '/bin/bash', 15:32:51 INFO - 'SHLVL': '1', 15:32:51 INFO - 'TERM': 'linux', 15:32:51 INFO - 'TMOUT': '86400', 15:32:51 INFO - 'USER': 'cltbld', 15:32:51 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1448318115.326639-59100879', 15:32:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:51 INFO - '_': '/tools/buildbot/bin/python'} 15:32:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:32:52 INFO - Running setup.py (path:/tmp/pip-znna9F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:32:52 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)) 15:32:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:32:52 INFO - Running setup.py (path:/tmp/pip-xt2n3D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:32:52 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)) 15:32:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:32:52 INFO - Running setup.py (path:/tmp/pip-OmkioD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:32:52 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)) 15:32:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:32:52 INFO - Running setup.py (path:/tmp/pip-zABFRY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:32:52 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)) 15:32:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:32:52 INFO - Running setup.py (path:/tmp/pip-kUqRla-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:32:52 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)) 15:32:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:32:52 INFO - Running setup.py (path:/tmp/pip-wBkXS3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:32:52 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)) 15:32:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:32:52 INFO - Running setup.py (path:/tmp/pip-LUiEdT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:32:52 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)) 15:32:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:32:52 INFO - Running setup.py (path:/tmp/pip-8AsjHR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:32:52 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)) 15:32:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:32:52 INFO - Running setup.py (path:/tmp/pip-kZavUO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:32:52 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)) 15:32:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:32:52 INFO - Running setup.py (path:/tmp/pip-ZfSNRg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:32:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 15:32:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:32:52 INFO - Running setup.py (path:/tmp/pip-fZfAoj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:32:52 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)) 15:32:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:32:52 INFO - Running setup.py (path:/tmp/pip-CstI4c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:32:53 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)) 15:32:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:32:53 INFO - Running setup.py (path:/tmp/pip-znDbpk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:32:53 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)) 15:32:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:32:53 INFO - Running setup.py (path:/tmp/pip-OUXiO_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:32:53 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)) 15:32:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:32:53 INFO - Running setup.py (path:/tmp/pip-rkFTQb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:32:53 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)) 15:32:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:32:53 INFO - Running setup.py (path:/tmp/pip-SzXOC1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:32:53 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)) 15:32:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:32:53 INFO - Running setup.py (path:/tmp/pip-Su5kWA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:32:53 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)) 15:32:53 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)) 15:32:53 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)) 15:32:53 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)) 15:32:53 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)) 15:32:53 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)) 15:32:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:32:53 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 15:32:53 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 15:32:53 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 15:32:53 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 15:32:53 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 15:32:53 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 15:32:55 INFO - Downloading blessings-1.5.1.tar.gz 15:32:55 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 15:32:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:32:55 INFO - Installing collected packages: blessings 15:32:55 INFO - Running setup.py install for blessings 15:32:55 INFO - Successfully installed blessings 15:32:55 INFO - Cleaning up... 15:32:55 INFO - Return code: 0 15:32:55 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:32:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:32:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:32:55 INFO - Reading from file tmpfile_stdout 15:32:55 INFO - Current package versions: 15:32:55 INFO - argparse == 1.2.1 15:32:55 INFO - blessings == 1.5.1 15:32:55 INFO - blobuploader == 1.2.4 15:32:55 INFO - docopt == 0.6.1 15:32:55 INFO - manifestparser == 1.1 15:32:55 INFO - mozInstall == 1.12 15:32:55 INFO - mozcrash == 0.16 15:32:55 INFO - mozdebug == 0.1 15:32:55 INFO - mozdevice == 0.47 15:32:55 INFO - mozfile == 1.2 15:32:55 INFO - mozhttpd == 0.7 15:32:55 INFO - mozinfo == 0.9 15:32:55 INFO - mozleak == 0.1 15:32:55 INFO - mozlog == 3.1 15:32:55 INFO - moznetwork == 0.27 15:32:55 INFO - mozprocess == 0.22 15:32:55 INFO - mozprofile == 0.27 15:32:55 INFO - mozrunner == 6.11 15:32:55 INFO - mozscreenshot == 0.1 15:32:55 INFO - mozsystemmonitor == 0.0 15:32:55 INFO - moztest == 0.7 15:32:55 INFO - mozversion == 1.4 15:32:55 INFO - psutil == 3.1.1 15:32:55 INFO - requests == 1.2.3 15:32:55 INFO - wsgiref == 0.1.2 15:32:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:55 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 0x7fde6e9c4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12916c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13437c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1387d70>, '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 0x1388b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1388fb0>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1448318115.326639-59100879', '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 15:32:55 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 15:32:55 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 15:32:55 INFO - Using env: {'DISPLAY': ':0', 15:32:55 INFO - 'HOME': '/home/cltbld', 15:32:55 INFO - 'LANG': 'en_US.UTF-8', 15:32:55 INFO - 'LANGUAGE': 'en_US:en', 15:32:55 INFO - 'LOGNAME': 'cltbld', 15:32:55 INFO - 'MAIL': '/var/mail/cltbld', 15:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:55 INFO - 'MOZ_NO_REMOTE': '1', 15:32:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:55 INFO - 'NO_EM_RESTART': '1', 15:32:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:32:55 INFO - 'PWD': '/builds/slave/test-pgo', 15:32:55 INFO - 'SHELL': '/bin/bash', 15:32:55 INFO - 'SHLVL': '1', 15:32:55 INFO - 'TERM': 'linux', 15:32:55 INFO - 'TMOUT': '86400', 15:32:55 INFO - 'USER': 'cltbld', 15:32:55 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1448318115.326639-59100879', 15:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:55 INFO - '_': '/tools/buildbot/bin/python'} 15:32:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:55 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)) 15:32:55 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)) 15:32:55 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)) 15:32:55 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)) 15:32:55 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)) 15:32:55 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)) 15:32:55 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)) 15:32:55 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)) 15:32:55 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)) 15:32:55 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)) 15:32:55 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)) 15:32:55 INFO - Cleaning up... 15:32:55 INFO - Return code: 0 15:32:55 INFO - Running post-action listener: _resource_record_post_action 15:32:55 INFO - Running post-action listener: _start_resource_monitoring 15:32:55 INFO - Starting resource monitoring. 15:32:55 INFO - ##### 15:32:55 INFO - ##### Running install step. 15:32:55 INFO - ##### 15:32:55 INFO - Running pre-action listener: _resource_record_pre_action 15:32:55 INFO - Running main action method: install 15:32:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:32:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:32:56 INFO - Reading from file tmpfile_stdout 15:32:56 INFO - Detecting whether we're running mozinstall >=1.0... 15:32:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:32:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:32:56 INFO - Reading from file tmpfile_stdout 15:32:56 INFO - Output received: 15:32:56 INFO - Usage: mozinstall [options] installer 15:32:56 INFO - Options: 15:32:56 INFO - -h, --help show this help message and exit 15:32:56 INFO - -d DEST, --destination=DEST 15:32:56 INFO - Directory to install application into. [default: 15:32:56 INFO - "/builds/slave/test-pgo"] 15:32:56 INFO - --app=APP Application being installed. [default: firefox] 15:32:56 INFO - mkdir: /builds/slave/test-pgo/build/application 15:32:56 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'] 15:32:56 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 15:33:10 INFO - Reading from file tmpfile_stdout 15:33:10 INFO - Output received: 15:33:10 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:33:10 INFO - Running post-action listener: _resource_record_post_action 15:33:10 INFO - ##### 15:33:10 INFO - ##### Running run-tests step. 15:33:10 INFO - ##### 15:33:10 INFO - Running pre-action listener: _resource_record_pre_action 15:33:10 INFO - Running main action method: run_tests 15:33:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:33:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:33:10 INFO - Python 2.7.3 15:33:10 INFO - Return code: 0 15:33:10 INFO - grabbing minidump binary from tooltool 15:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:10 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 0x1387d70>, '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 0x1388b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1388fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:33:10 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 15:33:10 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 15:33:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:33:10 INFO - Return code: 0 15:33:10 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:33:10 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:33:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:33:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:33:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:33:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FTp9ZoacSoG0DVJxV0fHEA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 15:33:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FTp9ZoacSoG0DVJxV0fHEA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost 15:33:10 INFO - Using env: {'DISPLAY': ':0', 15:33:10 INFO - 'HOME': '/home/cltbld', 15:33:10 INFO - 'LANG': 'en_US.UTF-8', 15:33:10 INFO - 'LANGUAGE': 'en_US:en', 15:33:10 INFO - 'LOGNAME': 'cltbld', 15:33:10 INFO - 'MAIL': '/var/mail/cltbld', 15:33:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:33:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:10 INFO - 'MOZ_NO_REMOTE': '1', 15:33:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:33:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:10 INFO - 'NO_EM_RESTART': '1', 15:33:10 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:33:10 INFO - 'PWD': '/builds/slave/test-pgo', 15:33:10 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:33:10 INFO - 'SHELL': '/bin/bash', 15:33:10 INFO - 'SHLVL': '1', 15:33:10 INFO - 'TERM': 'linux', 15:33:10 INFO - 'TMOUT': '86400', 15:33:10 INFO - 'USER': 'cltbld', 15:33:10 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1448318115.326639-59100879', 15:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:10 INFO - '_': '/tools/buildbot/bin/python'} 15:33:10 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FTp9ZoacSoG0DVJxV0fHEA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost'] with output_timeout 3600 15:33:11 INFO - mozversion INFO | application_buildid: 20151123143012 15:33:11 INFO - mozversion INFO | application_changeset: 18d63333b155fdcd07be32ae90336b304e232daa 15:33:11 INFO - mozversion INFO | application_display_name: Nightly 15:33:11 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:33:11 INFO - mozversion INFO | application_name: Firefox 15:33:11 INFO - mozversion INFO | application_remotingname: firefox 15:33:11 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 15:33:11 INFO - mozversion INFO | application_vendor: Mozilla 15:33:11 INFO - mozversion INFO | application_version: 45.0a1 15:33:11 INFO - mozversion INFO | platform_buildid: 20151123143012 15:33:11 INFO - mozversion INFO | platform_changeset: 18d63333b155fdcd07be32ae90336b304e232daa 15:33:11 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 15:33:11 INFO - mozversion INFO | platform_version: 45.0a1 15:33:11 INFO - 2015-11-23 15:33:11,029 DEBUG : using testdate: 1448321591 15:33:11 INFO - 2015-11-23 15:33:11,029 DEBUG : actual date: 1448321591 15:33:11 INFO - 2015-11-23 15:33:11,037 INFO : starting webserver on 'localhost:44055' 15:33:11 INFO - 2015-11-23 15:33:11,038 INFO : Starting test suite talos-linux64-ix-024 15:33:11 INFO - 2015-11-23 15:33:11,038 INFO : Starting test dromaeo_css 15:33:11 INFO - 2015-11-23 15:33:11,038 DEBUG : operating with platform_type : linux_ 15:33:11 INFO - 2015-11-23 15:33:11,039 INFO : Initialising browser for dromaeo_css test... 15:33:11 INFO - 2015-11-23 15:33:11,055 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0EYA9o/profile http://localhost:44055/getInfo.html 15:33:14 INFO - 2015-11-23 15:33:14,750 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:33:14 INFO - 2015-11-23 15:33:14,750 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:33:14 INFO - 2015-11-23 15:33:14,751 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:33:14 INFO - 2015-11-23 15:33:14,751 DEBUG : BROWSER_OUTPUT: __metrics 15:33:14 INFO - 2015-11-23 15:33:14,872 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:33:15 INFO - 2015-11-23 15:33:15,412 DEBUG : BROWSER_OUTPUT: console.error: 15:33:15 INFO - 2015-11-23 15:33:15,413 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 15:33:15 INFO - 2015-11-23 15:33:15,413 DEBUG : BROWSER_OUTPUT: Stack: 15:33:15 INFO - 2015-11-23 15:33:15,414 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 15:33:15 INFO - 2015-11-23 15:33:15,414 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 15:33:15 INFO - 2015-11-23 15:33:15,414 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 15:33:15 INFO - 2015-11-23 15:33:15,414 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 15:33:15 INFO - 2015-11-23 15:33:15,414 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 15:33:15 INFO - 2015-11-23 15:33:15,414 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 15:33:15 INFO - 2015-11-23 15:33:15,414 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 15:33:15 INFO - 2015-11-23 15:33:15,414 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 15:33:15 INFO - 2015-11-23 15:33:15,414 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 15:33:15 INFO - 2015-11-23 15:33:15,414 DEBUG : BROWSER_OUTPUT: 15:33:15 INFO - 2015-11-23 15:33:15,977 INFO : Browser initialized. 15:33:15 INFO - 2015-11-23 15:33:15,977 INFO : Running cycle 1/1 for dromaeo_css test... 15:33:15 INFO - 2015-11-23 15:33:15,978 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0EYA9o/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:33:27 INFO - 2015-11-23 15:33:27,684 DEBUG : BROWSER_OUTPUT: RSS: Main: 142217216 15:33:27 INFO - 2015-11-23 15:33:27,684 DEBUG : BROWSER_OUTPUT: 15:34:19 INFO - 2015-11-23 15:34:19,250 DEBUG : BROWSER_OUTPUT: 1448321659249 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] 15:36:27 INFO - 2015-11-23 15:36:27,789 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44055/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44055/tests/dromaeo/cssquery-ext.html) 15:36:29 INFO - 2015-11-23 15:36:29,083 DEBUG : BROWSER_OUTPUT: RSS: Main: 232095744 15:36:29 INFO - 2015-11-23 15:36:29,083 DEBUG : BROWSER_OUTPUT: 15:39:31 INFO - 2015-11-23 15:39:31,362 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44055/tests/dromaeo/cssquery-ext.html (next: http://localhost:44055/tests/dromaeo/cssquery-jquery.html) 15:39:31 INFO - 2015-11-23 15:39:31,943 DEBUG : BROWSER_OUTPUT: RSS: Main: 217698304 15:39:31 INFO - 2015-11-23 15:39:31,943 DEBUG : BROWSER_OUTPUT: 15:42:33 INFO - 2015-11-23 15:42:33,739 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44055/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44055/tests/dromaeo/cssquery-mootools.html) 15:42:34 INFO - 2015-11-23 15:42:34,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 224575488 15:42:34 INFO - 2015-11-23 15:42:34,308 DEBUG : BROWSER_OUTPUT: 15:45:36 INFO - 2015-11-23 15:45:36,214 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44055/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44055/tests/dromaeo/cssquery-prototype.html) 15:45:36 INFO - 2015-11-23 15:45:36,775 DEBUG : BROWSER_OUTPUT: RSS: Main: 199745536 15:45:36 INFO - 2015-11-23 15:45:36,776 DEBUG : BROWSER_OUTPUT: 15:48:39 INFO - 2015-11-23 15:48:39,323 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44055/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44055/tests/dromaeo/cssquery-yui.html) 15:48:39 INFO - 2015-11-23 15:48:39,884 DEBUG : BROWSER_OUTPUT: RSS: Main: 204144640 15:48:39 INFO - 2015-11-23 15:48:39,885 DEBUG : BROWSER_OUTPUT: 15:51:42 INFO - 2015-11-23 15:51:42,804 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44055/tests/dromaeo/cssquery-yui.html (next: http://localhost:44055/tests/dromaeo/cssquery-dojo.html) 15:51:43 INFO - 2015-11-23 15:51:43,054 DEBUG : BROWSER_OUTPUT: RSS: Main: 245526528 15:51:43 INFO - 2015-11-23 15:51:43,054 DEBUG : BROWSER_OUTPUT: 15:51:43 INFO - 2015-11-23 15:51:43,054 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:51:43 INFO - 2015-11-23 15:51:43,054 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:51:43 INFO - 2015-11-23 15:51:43,054 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:51:43 INFO - 2015-11-23 15:51:43,054 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:51:43 INFO - 2015-11-23 15:51:43,055 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3184.9681503184966;3217.501287300466;3262.1355340834666;3272.869085236589;3284.573005509284;5212.973935130329;5334.786608535654;5427.43011983742;5428.587046727389;5436.075867102592;5369.5704343652515;5393.59548033897;5424.7830086796575;5427.457254274571;5461.836144915659;4940.6047516198705;4989.600831933437;5005.224190250517;5031.72325522098;5042.5713814325645;4802.255650374198;5058.317127187837;5084.161113416282;5111.182210846266;5149.047426226141;4908.337374454439;4938.654294199426;5026.7486625668935;5040.6471546991725;5053.797848086072;5004.799808007675;5012.298278241013;5013.448520662724;5042.924356134661;5095.414027386861;4842.201036828919;4952.603791696692;4987.875303117415;4998.500149985009;5022.397312322508;5161.122609156452;5186.740662966874;5198.818041368534;5226.947730522684;5227.18978558324;5910.172575839386;5925;5931.940680593182;5949.702514874239;5950.5834591578605;5572.442755724435;5715.885682286331;5766.481016708474;5963.4334738199805;5972.402759723993;5490.094134467808;5565.66606003637;5571.693556854371;5580.693061881636;5592.748326325325;6032.276126864805;6039.758409663652;6048.213732214872;6056;6113.38866113394;5674.460926212003;5716.171155182558;5776.018076926933;5847.649141051551;5903.734331955073;5958.404159584007;5961.046232602849;5961.225040744762;5961.731722072517;5970.34326224115;5895.852603684943;5922.8815423691285;5947.940520594825;5959.374265702126;5959.910601340984;5740.942590574041;5826.883462330729;5855.151003104526;5904.557158213065;5947.881042379128;4494.056248187851;4510.864674059783;4537.8184872604725;4539.205639013159;4579.107074120581;3953.2686453006286;4031.697622678311;4039.2931237033404;4051.453053837753;4085.673146148301;5530.917036244459;5582.97208513963;5630.634008789416;5654.434556544313;5694.032014557535;5875.764969401262;5885.293764748258;5885.970570147122;5889.146073819272;5895.911561326584;5302.2576839241765;5397.541208997201;5564.638298510584;5566.304211973504;5567.2762540870235;5007.098722229961;5089.541941225308;5100.132977393852;5104.69371837691;5113.846584602468;6134.9079763803575;6139.26328840542;6139.84650383744;6141.293751218667;6150.538709596798;5638.915416268677;5697.8860422790485;5748.54011679073;5934.9406505934385;5941.079132734433;5824.70876456167;5859.2090067842;5868.2077919480325;5880.794172204123;5913.083472061838;5742.569307301886;5759.280089988752;5808.099744539603;5810.070388737781;5823.82528524145;5659.603827732019;5790.913136302875;5945.851353716019;5958.344582096052;5962.821115366546;5568.053430916835;5645.887082258414;5676;5685.545156387562;5697.059985102412;5707.8858422832145;5757.337906140848;5770.538356931519;5774.653520788766;5779.653220806765;5373.086575282133;5621.55027597783;5669.546436285004;5689.374168841507;5691.601587888808;5666.914996275142;5693.800716975052;5715.9142612860005;5766.192733017297;5785.132230165509;5659.490645841894;5692.686902220417;5726.341470730919;5736.512396446349;5778.884422311614 15:51:43 INFO - 2015-11-23 15:51:43,056 DEBUG : BROWSER_OUTPUT: |1;ext.html;563.8477611045018;612.3876123876124;615.2862679292025;618.7153909201768;619.9969000154998;30647.08058758238;31515.842420787892;39479.802600986994;39847.20305593894;40125.19749605006;43316.78341608288;43869.341959870624;43922.34116488255;43925.341119883145;44015;7326.413886889036;7483.77548673538;8605.95697021514;8792.296616270714;8797.516136612483;10365.689029329133;10558.630447934323;10624.78750424991;10630.096441802456;10647.361158330525;10316.742081447948;10423.843642345333;10426.165906727481;10433.373997560133;10436.530356133955;7464.477486575942;7581.052368453916;7585.2035536269;10095.545700443497;10241.33431326965;9773;9892.208623310118;9902.306838521306;9915.851262231072;9921.50392480373;36533.45199822005;36729.816350918074;37068.44397334042;37167.814160929294;37293;3307.9834600826844;3307.9834600826844;3353.6646335366268;3454.5681789776277;3626.2203626220225;29577.408451830845;30006;30131.69868301311;30273.243168920733;30360.54459183114;3747.8126093695205;3796.354619714655;3807.5240594925635;3819.732618716691;3824.1969186470874;267982;268322;269614;270369.999999998;270433;54895;55688;57712.4228757707;58043.419565804645;58345.124823127684;66868;67410;67423;67500.6624966872;67688.32311676918;15296.541103766682;15367.385304587915;15501.534953951399;15517.146556939251;15531.689366212839;12350.505979760888;12391.318477483825;12406.62780116598;12407.75184496305;12414.565490207799;19126.80873191278;19159.137838797287;19179.90410047941;19244.326448574233;19308.80691193098;7265.2371500992695;7415.073115860518;7442.18136005039;7460.328570428687;7467.215942325977;982.2436723722693;983.0513554420019;1000.3466547813656;1066.1896958311738;1122.859642544682;27980;28196.71803281982;28340.71659283422;29088.85455572751;29097;1007.4559737741538;1009.5356136177294;1077.902988731018;1085.46812062089;1115.252780636975;13529.59411217665;13717.588472345846;13722.382492787849;13888.791668124986;13953.511627093003;322963;326728;327378;327850;328335;50636.74681626568;50720.74639626852;50892.236616450784;51160.48839511557;51174.74412627913;1164.132721122752;1280.7310464802497;1343.8185844911006;1394.6443656867434;1444.111871199226;26038.479230415665;26085;26316.07871742008;26485.735142649097;26613;38863.61136388713;39069.41395879121;39124.6087539121;39234.411483828335;39412.408813867245;297498;305282;305819;372394;376726;30124.3975120492;30213.395732085675;30233.848830756586;30317.84841075869;30319;38706.80646596749;39263.41104883486;39773.40339894846;39849.2030159401;39869.20261594694;34953.126171845906;35009.47485787766;35295.11762205863;36118.4582231272;36128.819355903055;35954.4606830903;36265.456018159224;36734.8163259182;36764.080897977765;36912;35146;35509.46735798913;35615;35670.28659426745;35728.64271357357;30526.847365763027;32535.349293014482;33355.332893342485;33386;33411.66588334086;24092.87953560221;24364.390890227885;24409.51180976406;24465.266042018768;24764 15:51:43 INFO - 2015-11-23 15:51:43,057 DEBUG : BROWSER_OUTPUT: |2;jquery.html;342.5341535511702;348.69663392848224;351.93137338219026;352.67906205353125;354.1942081763987;14031.43874245029;14417.06289091211;16482.505524834243;16653.417130400438;17246.137693115343;14912.25438728062;15170.241487925614;16432.424865129724;16537.421190258345;16570.917145414285;5072.873178170538;5337.492938170868;5339.919901201485;5344.438833922441;5347.0909945309195;4015.3575427931537;4123.958760412387;5317.574594032488;5754.7410366533395;5978.312494063195;5875.76496940124;5880.735366908478;5884.176215329857;5925.051991681332;5931.436513531229;5719.28508936383;5883.646981181121;5907.763689452417;5931.792387266425;5938.435848594377;5195.766190521435;5212.218167274901;5215.191645294947;5221.556167725748;5232.450592687751;10372;10422;15825.841741582552;18247.908760456245;18776.62446751071;2134.082344591825;2169.4142581503065;2248.067052173346;2335.0426325206754;2403.9639405408934;9642.75893102671;9719.271054670857;9737.707868763877;9826.557804898797;9884;1870.2425517665367;1873.5409824592925;1886.1135266424758;1902.9714554281697;1903.6478251523513;58077;60039;60854;61291.387086129456;62117;9407.764805879771;9746.75633109178;9795.706128816148;9881.456519891475;9907.504624768733;12703.682407939876;12787.593364729872;12812.487500500061;12829.550965716342;12854.164479308814;7764.3788496920115;7791.883121753178;7868.291853733077;7874.842503149905;7888.2506161914525;7657.923420765833;7682.347000504908;7717.421193410517;7773.183815699384;7827.373810095179;4367.475902891673;4367.92985718501;4447.599716025573;4501.7974191161475;4516.277395616686;1704.0457343887215;1792.3637108826179;1795.8024617292087;1816.554944038719;1852.0832188066993;834.3033566971525;854.8546747053016;910.2490445382585;914.5792935249859;962.5572236771023;13810.723785524233;15478.226088695521;15559.611009724847;15929.840701593068;16158.111303878164;893.0578239956908;910.5674804467957;919.5999740113073;951.743029382063;951.8239125761618;8932.79407280022;9468.952655236817;9945.403275803475;10137;10209;485311;488710;491133;491899;497513;76008.61995690096;76425.23574764292;77287;78958.21041789623;79551;1169.8947094761513;1176.16492290473;1179.0862081886435;1188.744419949715;1190.0598527163445;15123.697526049638;15291;15316.617084572976;15437.768433473731;15580.143092130042;34285.48571771475;34800.129996750285;35017;35375.82312088423;35910.28179436344;45381.09237815159;46288.30567541557;46456.53543464522;47916.520834791205;48992.5100748988;9461.148496635336;9713.417194968324;9804.705858824247;9852.802943941224;9855.408675479493;11594.826077609012;16014.599635009217;17533.561660958578;17676.91161544184;17873;14546.709065818835;14623.268836558342;14756.557303280919;15021.02363346379;15083.491650834829;13990.510332138327;14339.350974637633;14465.566033019026;14732.484363047242;14841.554753357417;14745.336459859547;14950.401983920521;15087.39650414015;15248.3900643973;15339.23303834826;9561.282903782383;9684.903150968401;9750.853737193806;9762.17021553176;9766.316357854881;14418.42326306936;14591.124532528082;14681.412743490568;14929.02961307555;14939 15:51:43 INFO - 2015-11-23 15:51:43,058 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1349.2579081505169;1668.3743596151446;1734.1415999080457;1744.3197153110282;1771.362309568556;6684.866302673943;7152.713891444342;7422.4062075034;7437.44219183562;7440.739574114907;7539.39684825214;7641.923580764191;7646.885296720539;7649.885251721229;7662.501937374081;1972.4970132616163;1996.980030199701;1998.9200431982777;2226.6326056200705;2251.6397376419777;2004.9097790599385;2236.8769717665523;2281.030562011147;2283.098176220392;2287.0623044551735;2201.5816994770944;2244.147224054857;2251.133313674239;2279.2022792022744;2284.314705588325;2000.1699294792788;2050.3438899552148;2223.83321250906;2232.966505502419;2236.8322375821876;2193.484531135182;2241.4396400899777;2243.0242844362756;2243.461569223391;2244.259394399844;7556.622168891588;7682.270184332479;7684.423668224906;7691.961540192263;7693.730719424793;4653.208954477747;4716.976415117937;4749.643776716725;4753.595944344735;4755.785989630475;3037.104054303986;3194.6166460024715;3214.4053350130066;3220.1788543921384;3238.3685181389637;970.5486948568949;971.8299297622958;990.2622546203053;1008.500792107904;1043.8434234864756;10555;10558.577656893714;10565.3132546385;10581.259311848175;10601.469926503722;4204.957950420457;4269.124829409963;4321.308590625485;4323.308270676676;4334.45819272591;9063.81872362549;9065.320100992452;9082;9089.636414543476;9106.772330691785;4681.110588988149;4689.437267527918;4692.202325604655;4706.764661766898;4718.009218064176;4255.212785634668;4255.97872010638;4256.318988961813;4257.552956939477;4263.936040959388;3642.763220390666;3668.284684486553;3684.907877303035;3712.406015037581;3727.9068023299633;1198.287019223578;1209.8185272209064;1210.8546974362957;1212.4240985531978;1213.205350495427;1325.2578556008666;1330.314887832767;1349.156777014366;1364.8157498737544;1365.8975576831579;7193.784186474414;7295.52579082358;7348.559086454829;7354.521956072838;7363.263673632594;1105.6959336182454;1109.5561775289948;1114.2200459678259;1122.3826895207603;1126.723952631594;5511.366192887869;5613.635113717595;5786.189933409326;5840.561957853178;5955.196048533479;8699.434536755218;8796.296296296281;8899.065598112235;8901.198892099612;8917.687880924137;8904.688335908342;8968.461892286483;9063.501507417024;9082;9117.498537580497;7016.824579385556;7034.19106802714;7120.71517139319;7174.282571742784;7182.928170718226;6969.059177011241;7029.613371264425;7031.156261248479;7033.120859892513;7036.648167591497;8157.55133467665;8219.917800822155;8258.504489730636;8333.458325208841;8344.207300306462;8217.79455513617;8385.664573416994;8505.277051450448;8561.657533698582;8608.139186081342;6527.5430719849155;6575.901361479678;6651.06885036105;6674.8998765017595;6759.222689390783;7415.1101867776215;7496.362809161283;7500.62496875165;7502.062242219723;7504.699812007459;7097.82255443618;7109.502334836512;7116.822079447848;7219.169795473378;7222.09723784527;6948.687309071205;7001.194862590867;7044.859102818017;7062.788116356517;7091.11361079865;6340.461060809883;6770.187577490733;6853.314668533107;6891.793246202622;6901.240863505111;6328.177336946167;6412.647304398303;6439.581427207404;6444.7744328948265;6464.806055818333;6507.023946408077;6544.4764418845425;6589.47284217271;6593.967030164818;6608.801735947929 15:51:43 INFO - 2015-11-23 15:51:43,058 DEBUG : BROWSER_OUTPUT: |4;prototype.html;337.91889946412863;340.8755804131491;348.2008789827344;348.39031694534566;348.95463589733333;5839.532837373011;5999.850003749903;6010.909836352453;6012.939870601287;6035.486983606399;5779.62432441891;5936.821895343136;5951.375105613914;5961.821145365635;5964.582479226456;4609.3777340059;4612.561806628365;4617;4617.122746678137;4625.236835922077;4429.335599660045;4479.462464504264;4517.344984977176;4537.818487260505;4623.283391074388;4488.079943611552;4490.438695163105;4506.7070640408265;4517.390152329426;4527.230370836949;4487.618552423048;4496.7077139985795;4506.391637128995;4508.549145085498;4549.45406551216;3956.188981258835;3978.900527486807;3983.342748446503;3992.2215168042244;3995.6603688686496;5501.834944951658;5662.122371032497;5665.49010589049;5683.261176047087;5688.914666280009;5306.044911915854;5310.203469479609;5311.1767676009895;5312.574994000471;5313.867153321159;5991.400859914017;6336.968315158395;6340.429361357454;6344.809655710336;6350.364963503659;4191.119864828359;4308.332208507686;4390.8024138913825;4394.912101757979;4410.603045725868;6416.45460135889;6507.089007538948;6515.087887695727;6517.902231466532;6519.837004074936;4461.08547747711;4464.598186163261;4464.910701785946;4472.798724057425;4473.597376236155;4434.689571729948;4501.437320334958;4521.4574251089425;4538.523455037173;4545.749983750859;5240.9213861792105;5247.868803279948;5251.474852514794;5253.133233016586;5255.290535777621;6322.4942004639515;6330.4619107375465;6340.651264180515;6346.904796428057;6347.5556711029785;1587.3650539783948;1613.9112348820927;1619.684161588479;1620.440947872982;1626.8698504119643;1067.887871773468;1071.6999240212754;1075.7848430313968;1091.2797553614575;1097.2538673701958;6137.723802428812;6142.692865356715;6143.723532440961;6151.938480615226;6162.969185154046;6522.869542609121;6530.869382612416;6537.019447082976;6540.4767618590395;6540.509461790385;6002.39976002405;6134.263888333428;6144.9553575892205;6146.385361463817;6157.107219453154;3523.6652518010746;3542.00823769345;3544.8759293424605;3551.5915669697797;3553.129483276562;6699.866002679919;6735.02342160384;6738.393544581011;6753.898691519631;6755.594664320157;6554.213494380705;6654;6681.33186681328;6716.529842910949;6724.159480064992;6700.49746269022;6709.865802683919;6720.865582688417;6725.529212955144;6731.932680673229;6367.681615919279;6489.318621544669;6516.348365163446;6525.086487891794;6528.183977002875;6392.616443013434;6452.548321617442;6528.053432252202;6544.443722283469;6562.146920900444;6750.257471678014;6763.289854565397;6776.08522849409;6776.254611992776;6787.151606049244;4380.123975204908;4435.955640443554;4437.33439984005;4449.710768800018;4453.421055262925;6568.8357791055605;6575.736970521126;6587.341265873374;6587.901181482186;6588.209414870054;6406.455451286693;6413.1021656969;6416.550841441054;6417.358264173732;6418.390252925965;6226.034964580497;6365.427111559982;6372.299047104722;6399;6402.775902843378;6249.937500624936;6251.0623406487575;6259.436650701458;6259.6870156492905;6261.24865016201;6389.968050159905;6398.488120950406;6398.5521013528605;6406.13517175194;6409.7436102555375;6136.2636483622255;6241.656708881055;6247.656378899204;6248.187735594343;6293.307736149111 15:51:43 INFO - 2015-11-23 15:51:43,060 DEBUG : BROWSER_OUTPUT: |5;yui.html;736.7384578474645;738.1253214940297;746.4588173574156;762.4434163060965;844.9155084491549;13986.580402587913;14317.856821431782;14359.78460323096;14395.280235988197;14407.711845763104;13434.261115638636;13550.93224533876;13559.457621695145;13578.117422367539;13582.524611638595;681.2336121862904;683.8700646877103;809.1746418652971;813.5525460996444;831.6465502161587;824.1223097401248;824.8803923431099;830.339879795564;830.8255266394034;831.3930830493744;703.9331263529982;860.0754189246554;865.312076898867;866.2030931542964;866.2290561400358;697.9022936788854;846.7121178799207;851.3742399336545;856.1609622569854;860.1699360117517;637;638.9329120442379;638.9616623002588;639.434100820777;639.7984634840057;13140.60578182656;13291.268980206085;13296.26870522121;13299.468021279137;13315.467381304736;12318.876811231863;12784.232946023176;12939.48242070316;12942.288174150419;12996.610101696964;10304.94847525765;10412.479376031244;10531.26281160319;10623.575056997788;10637;3608.7293452990866;3657.3416784978695;3689.6863766579872;3721.925561488782;3769.076576238839;47378.76310618459;48535.75732121352;48581.51418485805;48634;48808;9561.229869393543;9755.317127801127;9821.558029888673;9889.10998010168;10206.193222604461;17767.555811104827;17771.644567108586;17786.91106544459;17816.376426824998;17830.19764110618;7569.962150189213;7604.619769011527;7684.577348245788;7746.961265193638;7829;4160.084781348099;4227.957720422756;4322.891927701769;4339.956600433955;4442.20040392726;3098.860551275198;3116.423461659555;3117.6570577236484;3117.828519431453;3121.1572875323536;526.9183276592134;542.8073034072926;556.6715637773733;557.3423360434726;557.9079451890393;534.6765207049757;593.2488283335613;619.5910698938679;641.9311845776823;671.6574546981075;9082.40964337316;9381.5309234538;9440.197583205505;9570.138687518156;9659.90340096604;534.5029122915726;651.775137577535;688.3391943734072;705.3792662457005;717.6304203335286;4062.2354670877603;4126.8761937141935;4220.810063547147;4311.396404503372;4417.884857879046;54058.729706352;54464.45535544594;54738.45261547413;54742.17886731702;54804.72597637066;48012.279815802794;48290.27564586534;48416;49905.25142122871;50061;44729.32906006347;45418.77290613526;45436.3184552232;45682;46275.30587041197;8385.371097167616;8404.663813447638;8498;8544.273736732199;8577.785555360917;33131.50302745509;33341.33317333688;33745.83127084349;33829.32341353208;34334.14164645904;39511;39843.60156398515;41074.58925410827;43783.78108109439;43898;11248.550057997589;11468.369239691898;11478.368689722145;11557.826632600685;11996.820047699117;12168.695782605506;12420.192687475284;12526.311052892179;12740.108192426442;12807.295598741786;11235.49440275206;11520.251183673034;11678.06575473977;11832.881671183179;11919.404029798301;11450.94274528622;11701.941490292495;11917.22538035025;11941.761164776482;12342.13605047638;7813.645500768486;10946.835797462885;11078.224524283223;11965.940170299093;12191.695207619881;9431.339806213773;9585.616575336908;9652.469114198506;9654.810835942508;9789.118979291898;9691.612335506783;9856.950715246378;9869.753256168653;9978.452673013242;10073.093421592092 15:51:43 INFO - 2015-11-23 15:51:43,060 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:51:43 INFO - 2015-11-23 15:51:43,060 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:51:43 INFO - 2015-11-23 15:51:43,060 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1000 15:51:43 INFO - 2015-11-23 15:51:43,060 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:51:43 INFO - 2015-11-23 15:51:43,060 DEBUG : BROWSER_OUTPUT: __startTimestamp1448322703053__endTimestamp 15:51:43 INFO - 2015-11-23 15:51:43,060 DEBUG : BROWSER_OUTPUT: 15:51:43 INFO - 2015-11-23 15:51:43,061 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:51:43 INFO - 2015-11-23 15:51:43,061 DEBUG : BROWSER_OUTPUT: Number of tests: 6 15:51:43 INFO - 2015-11-23 15:51:43,061 DEBUG : BROWSER_OUTPUT: 15:51:43 INFO - 2015-11-23 15:51:43,061 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5445.46 Median:5666.91 stddev:608.74 (10.7%) stddev-sans-first:584.21 15:51:43 INFO - 2015-11-23 15:51:43,062 DEBUG : BROWSER_OUTPUT: Values: 3185.0 3217.5 3262.1 3272.9 3284.6 5213.0 5334.8 5427.4 5428.6 5436.1 5369.6 5393.6 5424.8 5427.5 5461.8 4940.6 4989.6 5005.2 5031.7 5042.6 4802.3 5058.3 5084.2 5111.2 5149.0 4908.3 4938.7 5026.7 5040.6 5053.8 5004.8 5012.3 5013.4 5042.9 5095.4 4842.2 4952.6 4987.9 4998.5 5022.4 5161.1 5186.7 5198.8 5226.9 5227.2 5910.2 5925.0 5931.9 5949.7 5950.6 5572.4 5715.9 5766.5 5963.4 5972.4 5490.1 5565.7 5571.7 5580.7 5592.7 6032.3 6039.8 6048.2 6056.0 6113.4 5674.5 5716.2 5776.0 5847.6 5903.7 5958.4 5961.0 5961.2 5961.7 5970.3 5895.9 5922.9 5947.9 5959.4 5959.9 5740.9 5826.9 5855.2 5904.6 5947.9 4494.1 4510.9 4537.8 4539.2 4579.1 3953.3 4031.7 4039.3 4051.5 4085.7 5530.9 5583.0 5630.6 5654.4 5694.0 5875.8 5885.3 5886.0 5889.1 5895.9 5302.3 5397.5 5564.6 5566.3 5567.3 5007.1 5089.5 5100.1 5104.7 5113.8 6134.9 6139.3 6139.8 6141.3 6150.5 5638.9 5697.9 5748.5 5934.9 5941.1 5824.7 5859.2 5868.2 5880.8 5913.1 5742.6 5759.3 5808.1 5810.1 5823.8 5659.6 5790.9 5945.9 5958.3 5962.8 5568.1 5645.9 5676.0 5685.5 5697.1 5707.9 5757.3 5770.5 5774.7 5779.7 5373.1 5621.6 5669.5 5689.4 5691.6 5666.9 5693.8 5715.9 5766.2 5785.1 5659.5 5692.7 5726.3 5736.5 5778.9 15:51:43 INFO - 2015-11-23 15:51:43,062 DEBUG : BROWSER_OUTPUT: 15:51:43 INFO - 2015-11-23 15:51:43,062 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47371.41 Median:33398.83 stddev:81546.77 (244.2%) stddev-sans-first:81699.80 15:51:43 INFO - 2015-11-23 15:51:43,063 DEBUG : BROWSER_OUTPUT: Values: 563.8 612.4 615.3 618.7 620.0 30647.1 31515.8 39479.8 39847.2 40125.2 43316.8 43869.3 43922.3 43925.3 44015.0 7326.4 7483.8 8606.0 8792.3 8797.5 10365.7 10558.6 10624.8 10630.1 10647.4 10316.7 10423.8 10426.2 10433.4 10436.5 7464.5 7581.1 7585.2 10095.5 10241.3 9773.0 9892.2 9902.3 9915.9 9921.5 36533.5 36729.8 37068.4 37167.8 37293.0 3308.0 3308.0 3353.7 3454.6 3626.2 29577.4 30006.0 30131.7 30273.2 30360.5 3747.8 3796.4 3807.5 3819.7 3824.2 267982.0 268322.0 269614.0 270370.0 270433.0 54895.0 55688.0 57712.4 58043.4 58345.1 66868.0 67410.0 67423.0 67500.7 67688.3 15296.5 15367.4 15501.5 15517.1 15531.7 12350.5 12391.3 12406.6 12407.8 12414.6 19126.8 19159.1 19179.9 19244.3 19308.8 7265.2 7415.1 7442.2 7460.3 7467.2 982.2 983.1 1000.3 1066.2 1122.9 27980.0 28196.7 28340.7 29088.9 29097.0 1007.5 1009.5 1077.9 1085.5 1115.3 13529.6 13717.6 13722.4 13888.8 13953.5 322963.0 326728.0 327378.0 327850.0 328335.0 50636.7 50720.7 50892.2 51160.5 51174.7 1164.1 1280.7 1343.8 1394.6 1444.1 26038.5 26085.0 26316.1 26485.7 26613.0 38863.6 39069.4 39124.6 39234.4 39412.4 297498.0 305282.0 305819.0 372394.0 376726.0 30124.4 30213.4 30233.8 30317.8 30319.0 38706.8 39263.4 39773.4 39849.2 39869.2 34953.1 35009.5 35295.1 36118.5 36128.8 35954.5 36265.5 36734.8 36764.1 36912.0 35146.0 35509.5 35615.0 35670.3 35728.6 30526.8 32535.3 33355.3 33386.0 33411.7 24092.9 24364.4 24409.5 24465.3 24764.0 15:51:43 INFO - 2015-11-23 15:51:43,063 DEBUG : BROWSER_OUTPUT: 15:51:43 INFO - 2015-11-23 15:51:43,063 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27266.26 Median:4407.76 stddev:80270.35 (1821.1%) stddev-sans-first:80470.07 15:51:43 INFO - 2015-11-23 15:51:43,063 DEBUG : BROWSER_OUTPUT: Values: 342.5 348.7 351.9 352.7 354.2 14031.4 14417.1 16482.5 16653.4 17246.1 14912.3 15170.2 16432.4 16537.4 16570.9 5072.9 5337.5 5339.9 5344.4 5347.1 4015.4 4124.0 5317.6 5754.7 5978.3 5875.8 5880.7 5884.2 5925.1 5931.4 5719.3 5883.6 5907.8 5931.8 5938.4 5195.8 5212.2 5215.2 5221.6 5232.5 10372.0 10422.0 15825.8 18247.9 18776.6 2134.1 2169.4 2248.1 2335.0 2404.0 9642.8 9719.3 9737.7 9826.6 9884.0 1870.2 1873.5 1886.1 1903.0 1903.6 58077.0 60039.0 60854.0 61291.4 62117.0 9407.8 9746.8 9795.7 9881.5 9907.5 12703.7 12787.6 12812.5 12829.6 12854.2 7764.4 7791.9 7868.3 7874.8 7888.3 7657.9 7682.3 7717.4 7773.2 7827.4 4367.5 4367.9 4447.6 4501.8 4516.3 1704.0 1792.4 1795.8 1816.6 1852.1 834.3 854.9 910.2 914.6 962.6 13810.7 15478.2 15559.6 15929.8 16158.1 893.1 910.6 919.6 951.7 951.8 8932.8 9469.0 9945.4 10137.0 10209.0 485311.0 488710.0 491133.0 491899.0 497513.0 76008.6 76425.2 77287.0 78958.2 79551.0 1169.9 1176.2 1179.1 1188.7 1190.1 15123.7 15291.0 15316.6 15437.8 15580.1 34285.5 34800.1 35017.0 35375.8 35910.3 45381.1 46288.3 46456.5 47916.5 48992.5 9461.1 9713.4 9804.7 9852.8 9855.4 11594.8 16014.6 17533.6 17676.9 17873.0 14546.7 14623.3 14756.6 15021.0 15083.5 13990.5 14339.4 14465.6 14732.5 14841.6 14745.3 14950.4 15087.4 15248.4 15339.2 9561.3 9684.9 9750.9 9762.2 9766.3 14418.4 14591.1 14681.4 14929.0 14939.0 15:51:43 INFO - 2015-11-23 15:51:43,063 DEBUG : BROWSER_OUTPUT: 15:51:43 INFO - 2015-11-23 15:51:43,063 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5391.24 Median:6442.18 stddev:2748.29 (42.7%) stddev-sans-first:2739.20 15:51:43 INFO - 2015-11-23 15:51:43,063 DEBUG : BROWSER_OUTPUT: Values: 1349.3 1668.4 1734.1 1744.3 1771.4 6684.9 7152.7 7422.4 7437.4 7440.7 7539.4 7641.9 7646.9 7649.9 7662.5 1972.5 1997.0 1998.9 2226.6 2251.6 2004.9 2236.9 2281.0 2283.1 2287.1 2201.6 2244.1 2251.1 2279.2 2284.3 2000.2 2050.3 2223.8 2233.0 2236.8 2193.5 2241.4 2243.0 2243.5 2244.3 7556.6 7682.3 7684.4 7692.0 7693.7 4653.2 4717.0 4749.6 4753.6 4755.8 3037.1 3194.6 3214.4 3220.2 3238.4 970.5 971.8 990.3 1008.5 1043.8 10555.0 10558.6 10565.3 10581.3 10601.5 4205.0 4269.1 4321.3 4323.3 4334.5 9063.8 9065.3 9082.0 9089.6 9106.8 4681.1 4689.4 4692.2 4706.8 4718.0 4255.2 4256.0 4256.3 4257.6 4263.9 3642.8 3668.3 3684.9 3712.4 3727.9 1198.3 1209.8 1210.9 1212.4 1213.2 1325.3 1330.3 1349.2 1364.8 1365.9 7193.8 7295.5 7348.6 7354.5 7363.3 1105.7 1109.6 1114.2 1122.4 1126.7 5511.4 5613.6 5786.2 5840.6 5955.2 8699.4 8796.3 8899.1 8901.2 8917.7 8904.7 8968.5 9063.5 9082.0 9117.5 7016.8 7034.2 7120.7 7174.3 7182.9 6969.1 7029.6 7031.2 7033.1 7036.6 8157.6 8219.9 8258.5 8333.5 8344.2 8217.8 8385.7 8505.3 8561.7 8608.1 6527.5 6575.9 6651.1 6674.9 6759.2 7415.1 7496.4 7500.6 7502.1 7504.7 7097.8 7109.5 7116.8 7219.2 7222.1 6948.7 7001.2 7044.9 7062.8 7091.1 6340.5 6770.2 6853.3 6891.8 6901.2 6328.2 6412.6 6439.6 6444.8 6464.8 6507.0 6544.5 6589.5 6594.0 6608.8 15:51:43 INFO - 2015-11-23 15:51:43,063 DEBUG : BROWSER_OUTPUT: 15:51:43 INFO - 2015-11-23 15:51:43,063 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5293.75 Median:6024.21 stddev:1598.08 (26.5%) stddev-sans-first:1558.67 15:51:43 INFO - 2015-11-23 15:51:43,065 DEBUG : BROWSER_OUTPUT: Values: 337.9 340.9 348.2 348.4 349.0 5839.5 5999.9 6010.9 6012.9 6035.5 5779.6 5936.8 5951.4 5961.8 5964.6 4609.4 4612.6 4617.0 4617.1 4625.2 4429.3 4479.5 4517.3 4537.8 4623.3 4488.1 4490.4 4506.7 4517.4 4527.2 4487.6 4496.7 4506.4 4508.5 4549.5 3956.2 3978.9 3983.3 3992.2 3995.7 5501.8 5662.1 5665.5 5683.3 5688.9 5306.0 5310.2 5311.2 5312.6 5313.9 5991.4 6337.0 6340.4 6344.8 6350.4 4191.1 4308.3 4390.8 4394.9 4410.6 6416.5 6507.1 6515.1 6517.9 6519.8 4461.1 4464.6 4464.9 4472.8 4473.6 4434.7 4501.4 4521.5 4538.5 4545.7 5240.9 5247.9 5251.5 5253.1 5255.3 6322.5 6330.5 6340.7 6346.9 6347.6 1587.4 1613.9 1619.7 1620.4 1626.9 1067.9 1071.7 1075.8 1091.3 1097.3 6137.7 6142.7 6143.7 6151.9 6163.0 6522.9 6530.9 6537.0 6540.5 6540.5 6002.4 6134.3 6145.0 6146.4 6157.1 3523.7 3542.0 3544.9 3551.6 3553.1 6699.9 6735.0 6738.4 6753.9 6755.6 6554.2 6654.0 6681.3 6716.5 6724.2 6700.5 6709.9 6720.9 6725.5 6731.9 6367.7 6489.3 6516.3 6525.1 6528.2 6392.6 6452.5 6528.1 6544.4 6562.1 6750.3 6763.3 6776.1 6776.3 6787.2 4380.1 4436.0 4437.3 4449.7 4453.4 6568.8 6575.7 6587.3 6587.9 6588.2 6406.5 6413.1 6416.6 6417.4 6418.4 6226.0 6365.4 6372.3 6399.0 6402.8 6249.9 6251.1 6259.4 6259.7 6261.2 6390.0 6398.5 6398.6 6406.1 6409.7 6136.3 6241.7 6247.7 6248.2 6293.3 15:51:43 INFO - 2015-11-23 15:51:43,065 DEBUG : BROWSER_OUTPUT: 15:51:43 INFO - 2015-11-23 15:51:43,065 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13612.22 Median:46827.03 stddev:15315.86 (32.7%) stddev-sans-first:15328.31 15:51:43 INFO - 2015-11-23 15:51:43,065 DEBUG : BROWSER_OUTPUT: Values: 736.7 738.1 746.5 762.4 844.9 13986.6 14317.9 14359.8 14395.3 14407.7 13434.3 13550.9 13559.5 13578.1 13582.5 681.2 683.9 809.2 813.6 831.6 824.1 824.9 830.3 830.8 831.4 703.9 860.1 865.3 866.2 866.2 697.9 846.7 851.4 856.2 860.2 637.0 638.9 639.0 639.4 639.8 13140.6 13291.3 13296.3 13299.5 13315.5 12318.9 12784.2 12939.5 12942.3 12996.6 10304.9 10412.5 10531.3 10623.6 10637.0 3608.7 3657.3 3689.7 3721.9 3769.1 47378.8 48535.8 48581.5 48634.0 48808.0 9561.2 9755.3 9821.6 9889.1 10206.2 17767.6 17771.6 17786.9 17816.4 17830.2 7570.0 7604.6 7684.6 7747.0 7829.0 4160.1 4228.0 4322.9 4340.0 4442.2 3098.9 3116.4 3117.7 3117.8 3121.2 526.9 542.8 556.7 557.3 557.9 534.7 593.2 619.6 641.9 671.7 9082.4 9381.5 9440.2 9570.1 9659.9 534.5 651.8 688.3 705.4 717.6 4062.2 4126.9 4220.8 4311.4 4417.9 54058.7 54464.5 54738.5 54742.2 54804.7 48012.3 48290.3 48416.0 49905.3 50061.0 44729.3 45418.8 45436.3 45682.0 46275.3 8385.4 8404.7 8498.0 8544.3 8577.8 33131.5 33341.3 33745.8 33829.3 34334.1 39511.0 39843.6 41074.6 43783.8 43898.0 11248.6 11468.4 11478.4 11557.8 11996.8 12168.7 12420.2 12526.3 12740.1 12807.3 11235.5 11520.3 11678.1 11832.9 11919.4 11450.9 11701.9 11917.2 11941.8 12342.1 7813.6 10946.8 11078.2 11965.9 12191.7 9431.3 9585.6 9652.5 9654.8 9789.1 9691.6 9857.0 9869.8 9978.5 10073.1 15:51:43 INFO - 2015-11-23 15:51:43,065 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:51:43 INFO - 2015-11-23 15:51:43,065 DEBUG : BROWSER_OUTPUT: 15:51:43 INFO - 2015-11-23 15:51:43,703 INFO : Browser exited with error code: 0 15:51:43 INFO - 2015-11-23 15:51:43,726 INFO : Completed test dromaeo_css (00:18:32) 15:51:43 INFO - 2015-11-23 15:51:43,726 INFO : Starting test kraken 15:51:43 INFO - 2015-11-23 15:51:43,726 DEBUG : operating with platform_type : linux_ 15:51:43 INFO - 2015-11-23 15:51:43,727 INFO : Initialising browser for kraken test... 15:51:43 INFO - 2015-11-23 15:51:43,733 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzGFwFa/profile http://localhost:44055/getInfo.html 15:51:47 INFO - 2015-11-23 15:51:47,372 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:51:47 INFO - 2015-11-23 15:51:47,372 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:51:47 INFO - 2015-11-23 15:51:47,372 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:51:47 INFO - 2015-11-23 15:51:47,372 DEBUG : BROWSER_OUTPUT: __metrics 15:51:47 INFO - 2015-11-23 15:51:47,500 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:51:48 INFO - 2015-11-23 15:51:48,653 INFO : Browser initialized. 15:51:48 INFO - 2015-11-23 15:51:48,654 INFO : Running cycle 1/1 for kraken test... 15:51:48 INFO - 2015-11-23 15:51:48,654 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzGFwFa/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:52:00 INFO - 2015-11-23 15:52:00,491 DEBUG : BROWSER_OUTPUT: RSS: Main: 139800576 15:52:00 INFO - 2015-11-23 15:52:00,491 DEBUG : BROWSER_OUTPUT: 15:52:02 INFO - 2015-11-23 15:52:02,927 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44055/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44055/tests/kraken/driver.html?testName=audio-beat-detection) 15:52:03 INFO - 2015-11-23 15:52:03,500 DEBUG : BROWSER_OUTPUT: RSS: Main: 179040256 15:52:03 INFO - 2015-11-23 15:52:03,502 DEBUG : BROWSER_OUTPUT: 15:52:06 INFO - 2015-11-23 15:52:06,070 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44055/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44055/tests/kraken/driver.html?testName=audio-dft) 15:52:06 INFO - 2015-11-23 15:52:06,635 DEBUG : BROWSER_OUTPUT: RSS: Main: 168431616 15:52:06 INFO - 2015-11-23 15:52:06,636 DEBUG : BROWSER_OUTPUT: 15:52:09 INFO - 2015-11-23 15:52:09,520 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44055/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44055/tests/kraken/driver.html?testName=audio-fft) 15:52:10 INFO - 2015-11-23 15:52:10,081 DEBUG : BROWSER_OUTPUT: RSS: Main: 152481792 15:52:10 INFO - 2015-11-23 15:52:10,082 DEBUG : BROWSER_OUTPUT: 15:52:12 INFO - 2015-11-23 15:52:12,060 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44055/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44055/tests/kraken/driver.html?testName=audio-oscillator) 15:52:12 INFO - 2015-11-23 15:52:12,625 DEBUG : BROWSER_OUTPUT: RSS: Main: 154791936 15:52:12 INFO - 2015-11-23 15:52:12,625 DEBUG : BROWSER_OUTPUT: 15:52:14 INFO - 2015-11-23 15:52:14,827 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44055/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44055/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:52:15 INFO - 2015-11-23 15:52:15,388 DEBUG : BROWSER_OUTPUT: RSS: Main: 156286976 15:52:15 INFO - 2015-11-23 15:52:15,388 DEBUG : BROWSER_OUTPUT: 15:52:18 INFO - 2015-11-23 15:52:18,311 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44055/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44055/tests/kraken/driver.html?testName=imaging-darkroom) 15:52:18 INFO - 2015-11-23 15:52:18,884 DEBUG : BROWSER_OUTPUT: RSS: Main: 155029504 15:52:18 INFO - 2015-11-23 15:52:18,885 DEBUG : BROWSER_OUTPUT: 15:52:22 INFO - 2015-11-23 15:52:22,287 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44055/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44055/tests/kraken/driver.html?testName=imaging-desaturate) 15:52:22 INFO - 2015-11-23 15:52:22,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 157523968 15:52:22 INFO - 2015-11-23 15:52:22,856 DEBUG : BROWSER_OUTPUT: 15:52:25 INFO - 2015-11-23 15:52:25,658 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44055/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44055/tests/kraken/driver.html?testName=json-parse-financial) 15:52:26 INFO - 2015-11-23 15:52:26,232 DEBUG : BROWSER_OUTPUT: RSS: Main: 157949952 15:52:26 INFO - 2015-11-23 15:52:26,232 DEBUG : BROWSER_OUTPUT: 15:52:27 INFO - 2015-11-23 15:52:27,805 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44055/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44055/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:52:28 INFO - 2015-11-23 15:52:28,371 DEBUG : BROWSER_OUTPUT: RSS: Main: 169414656 15:52:28 INFO - 2015-11-23 15:52:28,371 DEBUG : BROWSER_OUTPUT: 15:52:30 INFO - 2015-11-23 15:52:30,160 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44055/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44055/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:52:30 INFO - 2015-11-23 15:52:30,761 DEBUG : BROWSER_OUTPUT: RSS: Main: 169398272 15:52:30 INFO - 2015-11-23 15:52:30,761 DEBUG : BROWSER_OUTPUT: 15:52:32 INFO - 2015-11-23 15:52:32,817 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44055/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44055/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:52:33 INFO - 2015-11-23 15:52:33,385 DEBUG : BROWSER_OUTPUT: RSS: Main: 177909760 15:52:33 INFO - 2015-11-23 15:52:33,385 DEBUG : BROWSER_OUTPUT: 15:52:35 INFO - 2015-11-23 15:52:35,778 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44055/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44055/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:52:36 INFO - 2015-11-23 15:52:36,359 DEBUG : BROWSER_OUTPUT: RSS: Main: 182603776 15:52:36 INFO - 2015-11-23 15:52:36,360 DEBUG : BROWSER_OUTPUT: 15:52:38 INFO - 2015-11-23 15:52:38,920 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44055/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44055/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:52:39 INFO - 2015-11-23 15:52:39,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 178950144 15:52:39 INFO - 2015-11-23 15:52:39,493 DEBUG : BROWSER_OUTPUT: 15:52:41 INFO - 2015-11-23 15:52:41,162 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44055/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44055/tests/kraken/driver.html?testName=ai-astar) 15:52:41 INFO - 2015-11-23 15:52:41,408 DEBUG : BROWSER_OUTPUT: RSS: Main: 238780416 15:52:41 INFO - 2015-11-23 15:52:41,408 DEBUG : BROWSER_OUTPUT: 15:52:41 INFO - 2015-11-23 15:52:41,410 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:52:41 INFO - 2015-11-23 15:52:41,410 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:52:41 INFO - 2015-11-23 15:52:41,410 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:52:41 INFO - 2015-11-23 15:52:41,410 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:52:41 INFO - 2015-11-23 15:52:41,411 DEBUG : BROWSER_OUTPUT: |0;ai-astar;107;110;102;109;109;111;97;108;110;99 15:52:41 INFO - 2015-11-23 15:52:41,411 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;123;145;165;129;152;157;125;160;125 15:52:41 INFO - 2015-11-23 15:52:41,411 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;164;162;163;163;164;162;163;166;165 15:52:41 INFO - 2015-11-23 15:52:41,411 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;83;92;71;74;72;99;97;72 15:52:41 INFO - 2015-11-23 15:52:41,412 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;143;92;93;93;142;93;94;138 15:52:41 INFO - 2015-11-23 15:52:41,412 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;110;109;109;109 15:52:41 INFO - 2015-11-23 15:52:41,412 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;146;145;144;144;146;145;145;145 15:52:41 INFO - 2015-11-23 15:52:41,412 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;97;95;95;95;96;95;96;96;95 15:52:41 INFO - 2015-11-23 15:52:41,413 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;57;59;57;59;56;64;58;60;57 15:52:41 INFO - 2015-11-23 15:52:41,413 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;68;68;69;70;69;69;69;69 15:52:41 INFO - 2015-11-23 15:52:41,413 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;86;86;84;91;83;83;84;86;86 15:52:41 INFO - 2015-11-23 15:52:41,414 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;114;115;121;116;122;118;120;130;123;118 15:52:41 INFO - 2015-11-23 15:52:41,414 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;144;148;149;149;152;139;161;150;142;140 15:52:41 INFO - 2015-11-23 15:52:41,414 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;66;65;67;67;66;65;66;67;69 15:52:41 INFO - 2015-11-23 15:52:41,414 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:52:41 INFO - 2015-11-23 15:52:41,415 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:52:41 INFO - 2015-11-23 15:52:41,415 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,909 15:52:41 INFO - 2015-11-23 15:52:41,415 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:52:41 INFO - 2015-11-23 15:52:41,415 DEBUG : BROWSER_OUTPUT: __startTimestamp1448322761409__endTimestamp 15:52:41 INFO - 2015-11-23 15:52:41,415 DEBUG : BROWSER_OUTPUT: 15:52:41 INFO - 2015-11-23 15:52:41,416 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:52:41 INFO - 2015-11-23 15:52:41,416 DEBUG : BROWSER_OUTPUT: Number of tests: 14 15:52:41 INFO - 2015-11-23 15:52:41,417 DEBUG : BROWSER_OUTPUT: 15:52:41 INFO - 2015-11-23 15:52:41,417 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.20 Median:110.00 stddev:5.01 (4.6%) stddev-sans-first:5.30 15:52:41 INFO - 2015-11-23 15:52:41,417 DEBUG : BROWSER_OUTPUT: Values: 107.0 110.0 102.0 109.0 109.0 111.0 97.0 108.0 110.0 99.0 15:52:41 INFO - 2015-11-23 15:52:41,417 DEBUG : BROWSER_OUTPUT: 15:52:41 INFO - 2015-11-23 15:52:41,417 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.40 Median:152.50 stddev:16.32 (10.7%) stddev-sans-first:16.93 15:52:41 INFO - 2015-11-23 15:52:41,417 DEBUG : BROWSER_OUTPUT: Values: 153.0 123.0 145.0 165.0 129.0 152.0 157.0 125.0 160.0 125.0 15:52:41 INFO - 2015-11-23 15:52:41,417 DEBUG : BROWSER_OUTPUT: 15:52:41 INFO - 2015-11-23 15:52:41,417 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.50 Median:163.50 stddev:1.27 (0.8%) stddev-sans-first:1.33 15:52:41 INFO - 2015-11-23 15:52:41,417 DEBUG : BROWSER_OUTPUT: Values: 163.0 164.0 162.0 163.0 163.0 164.0 162.0 163.0 166.0 165.0 15:52:41 INFO - 2015-11-23 15:52:41,417 DEBUG : BROWSER_OUTPUT: 15:52:41 INFO - 2015-11-23 15:52:41,418 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.40 Median:78.50 stddev:11.42 (14.6%) stddev-sans-first:11.70 15:52:41 INFO - 2015-11-23 15:52:41,418 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 83.0 92.0 71.0 74.0 72.0 99.0 97.0 72.0 15:52:41 INFO - 2015-11-23 15:52:41,418 DEBUG : BROWSER_OUTPUT: 15:52:41 INFO - 2015-11-23 15:52:41,418 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.40 Median:93.00 stddev:23.22 (25.0%) stddev-sans-first:24.04 15:52:41 INFO - 2015-11-23 15:52:41,418 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 143.0 92.0 93.0 93.0 142.0 93.0 94.0 138.0 15:52:41 INFO - 2015-11-23 15:52:41,418 DEBUG : BROWSER_OUTPUT: 15:52:41 INFO - 2015-11-23 15:52:41,418 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 15:52:41 INFO - 2015-11-23 15:52:41,418 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 15:52:41 INFO - 2015-11-23 15:52:41,418 DEBUG : BROWSER_OUTPUT: 15:52:41 INFO - 2015-11-23 15:52:41,419 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 15:52:41 INFO - 2015-11-23 15:52:41,419 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 146.0 145.0 144.0 144.0 146.0 145.0 145.0 145.0 15:52:41 INFO - 2015-11-23 15:52:41,419 DEBUG : BROWSER_OUTPUT: 15:52:41 INFO - 2015-11-23 15:52:41,419 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 15:52:41 INFO - 2015-11-23 15:52:41,419 DEBUG : BROWSER_OUTPUT: Values: 95.0 97.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 15:52:41 INFO - 2015-11-23 15:52:41,419 DEBUG : BROWSER_OUTPUT: 15:52:41 INFO - 2015-11-23 15:52:41,419 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.50 Median:58.50 stddev:2.27 (3.9%) stddev-sans-first:2.40 15:52:41 INFO - 2015-11-23 15:52:41,419 DEBUG : BROWSER_OUTPUT: Values: 58.0 57.0 59.0 57.0 59.0 56.0 64.0 58.0 60.0 57.0 15:52:41 INFO - 2015-11-23 15:52:41,419 DEBUG : BROWSER_OUTPUT: 15:52:41 INFO - 2015-11-23 15:52:41,420 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.84 (1.2%) stddev-sans-first:0.67 15:52:41 INFO - 2015-11-23 15:52:41,420 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 68.0 68.0 69.0 70.0 69.0 69.0 69.0 69.0 15:52:41 INFO - 2015-11-23 15:52:41,420 DEBUG : BROWSER_OUTPUT: 15:52:41 INFO - 2015-11-23 15:52:41,420 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:86.00 stddev:2.32 (2.7%) stddev-sans-first:2.46 15:52:41 INFO - 2015-11-23 15:52:41,420 DEBUG : BROWSER_OUTPUT: Values: 85.0 86.0 86.0 84.0 91.0 83.0 83.0 84.0 86.0 86.0 15:52:41 INFO - 2015-11-23 15:52:41,420 DEBUG : BROWSER_OUTPUT: 15:52:41 INFO - 2015-11-23 15:52:41,420 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.70 Median:120.50 stddev:4.69 (3.9%) stddev-sans-first:4.50 15:52:41 INFO - 2015-11-23 15:52:41,420 DEBUG : BROWSER_OUTPUT: Values: 114.0 115.0 121.0 116.0 122.0 118.0 120.0 130.0 123.0 118.0 15:52:41 INFO - 2015-11-23 15:52:41,420 DEBUG : BROWSER_OUTPUT: 15:52:41 INFO - 2015-11-23 15:52:41,421 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.40 Median:149.00 stddev:6.54 (4.4%) stddev-sans-first:6.82 15:52:41 INFO - 2015-11-23 15:52:41,421 DEBUG : BROWSER_OUTPUT: Values: 144.0 148.0 149.0 149.0 152.0 139.0 161.0 150.0 142.0 140.0 15:52:41 INFO - 2015-11-23 15:52:41,421 DEBUG : BROWSER_OUTPUT: 15:52:41 INFO - 2015-11-23 15:52:41,421 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.42 (2.1%) stddev-sans-first:1.24 15:52:41 INFO - 2015-11-23 15:52:41,421 DEBUG : BROWSER_OUTPUT: Values: 69.0 66.0 65.0 67.0 67.0 66.0 65.0 66.0 67.0 69.0 15:52:41 INFO - 2015-11-23 15:52:41,421 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:52:41 INFO - 2015-11-23 15:52:41,421 DEBUG : BROWSER_OUTPUT: 15:52:42 INFO - 2015-11-23 15:52:42,259 INFO : Browser exited with error code: 0 15:52:42 INFO - 2015-11-23 15:52:42,315 INFO : Completed test kraken (00:00:58) 15:52:42 INFO - 2015-11-23 15:52:42,315 INFO : Starting test v8_7 15:52:42 INFO - 2015-11-23 15:52:42,315 DEBUG : operating with platform_type : linux_ 15:52:42 INFO - 2015-11-23 15:52:42,315 INFO : Initialising browser for v8_7 test... 15:52:42 INFO - 2015-11-23 15:52:42,321 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpt3nOez/profile http://localhost:44055/getInfo.html 15:52:45 INFO - 2015-11-23 15:52:45,913 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:52:45 INFO - 2015-11-23 15:52:45,913 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:52:45 INFO - 2015-11-23 15:52:45,913 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:52:45 INFO - 2015-11-23 15:52:45,913 DEBUG : BROWSER_OUTPUT: __metrics 15:52:46 INFO - 2015-11-23 15:52:46,030 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:52:47 INFO - 2015-11-23 15:52:47,091 INFO : Browser initialized. 15:52:47 INFO - 2015-11-23 15:52:47,092 INFO : Running cycle 1/1 for v8_7 test... 15:52:47 INFO - 2015-11-23 15:52:47,092 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpt3nOez/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:52:58 INFO - 2015-11-23 15:52:58,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 142249984 15:52:58 INFO - 2015-11-23 15:52:58,913 DEBUG : BROWSER_OUTPUT: 15:53:20 INFO - 2015-11-23 15:53:20,366 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44055/tests/v8_7/run.html (next: http://localhost:44055/tests/v8_7/run.html) 15:53:20 INFO - 2015-11-23 15:53:20,616 DEBUG : BROWSER_OUTPUT: RSS: Main: 626253824 15:53:20 INFO - 2015-11-23 15:53:20,616 DEBUG : BROWSER_OUTPUT: 15:53:20 INFO - 2015-11-23 15:53:20,617 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:53:20 INFO - 2015-11-23 15:53:20,617 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:53:20 INFO - 2015-11-23 15:53:20,617 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:53:20 INFO - 2015-11-23 15:53:20,618 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:53:20 INFO - 2015-11-23 15:53:20,618 DEBUG : BROWSER_OUTPUT: |0;Richards;186.25442354255912 15:53:20 INFO - 2015-11-23 15:53:20,618 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.02405898331392 15:53:20 INFO - 2015-11-23 15:53:20,618 DEBUG : BROWSER_OUTPUT: |2;Encrypt;283.84899233607723 15:53:20 INFO - 2015-11-23 15:53:20,618 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5010 15:53:20 INFO - 2015-11-23 15:53:20,618 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1951.2670565302144 15:53:20 INFO - 2015-11-23 15:53:20,618 DEBUG : BROWSER_OUTPUT: |5;Earley;781.25 15:53:20 INFO - 2015-11-23 15:53:20,619 DEBUG : BROWSER_OUTPUT: |6;Boyer;12456.79012345679 15:53:20 INFO - 2015-11-23 15:53:20,619 DEBUG : BROWSER_OUTPUT: |7;RegExp;25525 15:53:20 INFO - 2015-11-23 15:53:20,619 DEBUG : BROWSER_OUTPUT: |8;Splay;683.7270341207349 15:53:20 INFO - 2015-11-23 15:53:20,619 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 15:53:20 INFO - 2015-11-23 15:53:20,619 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:53:20 INFO - 2015-11-23 15:53:20,619 DEBUG : BROWSER_OUTPUT: __startTimestamp1448322800616__endTimestamp 15:53:20 INFO - 2015-11-23 15:53:20,619 DEBUG : BROWSER_OUTPUT: 15:53:20 INFO - 2015-11-23 15:53:20,619 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:53:20 INFO - 2015-11-23 15:53:20,619 DEBUG : BROWSER_OUTPUT: Number of tests: 10 15:53:20 INFO - 2015-11-23 15:53:20,619 DEBUG : BROWSER_OUTPUT: 15:53:20 INFO - 2015-11-23 15:53:20,619 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:186.25 Median:186.25 stddev:0.00 (0.0%) 15:53:20 INFO - 2015-11-23 15:53:20,619 DEBUG : BROWSER_OUTPUT: Values: 186.3 15:53:20 INFO - 2015-11-23 15:53:20,620 DEBUG : BROWSER_OUTPUT: 15:53:20 INFO - 2015-11-23 15:53:20,620 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.02 Median:194.02 stddev:0.00 (0.0%) 15:53:20 INFO - 2015-11-23 15:53:20,620 DEBUG : BROWSER_OUTPUT: Values: 194.0 15:53:20 INFO - 2015-11-23 15:53:20,620 DEBUG : BROWSER_OUTPUT: 15:53:20 INFO - 2015-11-23 15:53:20,620 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:283.85 Median:283.85 stddev:0.00 (0.0%) 15:53:20 INFO - 2015-11-23 15:53:20,620 DEBUG : BROWSER_OUTPUT: Values: 283.8 15:53:20 INFO - 2015-11-23 15:53:20,620 DEBUG : BROWSER_OUTPUT: 15:53:20 INFO - 2015-11-23 15:53:20,620 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5010.00 Median:5010.00 stddev:0.00 (0.0%) 15:53:20 INFO - 2015-11-23 15:53:20,620 DEBUG : BROWSER_OUTPUT: Values: 5010.0 15:53:20 INFO - 2015-11-23 15:53:20,620 DEBUG : BROWSER_OUTPUT: 15:53:20 INFO - 2015-11-23 15:53:20,620 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1951.27 Median:1951.27 stddev:0.00 (0.0%) 15:53:20 INFO - 2015-11-23 15:53:20,621 DEBUG : BROWSER_OUTPUT: Values: 1951.3 15:53:20 INFO - 2015-11-23 15:53:20,621 DEBUG : BROWSER_OUTPUT: 15:53:20 INFO - 2015-11-23 15:53:20,621 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:781.25 Median:781.25 stddev:0.00 (0.0%) 15:53:20 INFO - 2015-11-23 15:53:20,621 DEBUG : BROWSER_OUTPUT: Values: 781.3 15:53:20 INFO - 2015-11-23 15:53:20,621 DEBUG : BROWSER_OUTPUT: 15:53:20 INFO - 2015-11-23 15:53:20,621 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12456.79 Median:12456.79 stddev:0.00 (0.0%) 15:53:20 INFO - 2015-11-23 15:53:20,621 DEBUG : BROWSER_OUTPUT: Values: 12456.8 15:53:20 INFO - 2015-11-23 15:53:20,621 DEBUG : BROWSER_OUTPUT: 15:53:20 INFO - 2015-11-23 15:53:20,621 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25525.00 Median:25525.00 stddev:0.00 (0.0%) 15:53:20 INFO - 2015-11-23 15:53:20,621 DEBUG : BROWSER_OUTPUT: Values: 25525.0 15:53:20 INFO - 2015-11-23 15:53:20,621 DEBUG : BROWSER_OUTPUT: 15:53:20 INFO - 2015-11-23 15:53:20,621 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:683.73 Median:683.73 stddev:0.00 (0.0%) 15:53:20 INFO - 2015-11-23 15:53:20,621 DEBUG : BROWSER_OUTPUT: Values: 683.7 15:53:20 INFO - 2015-11-23 15:53:20,622 DEBUG : BROWSER_OUTPUT: 15:53:20 INFO - 2015-11-23 15:53:20,622 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 15:53:20 INFO - 2015-11-23 15:53:20,622 DEBUG : BROWSER_OUTPUT: Values: 4826.9 15:53:20 INFO - 2015-11-23 15:53:20,622 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:53:20 INFO - 2015-11-23 15:53:20,622 DEBUG : BROWSER_OUTPUT: 15:53:21 INFO - 2015-11-23 15:53:21,472 INFO : Browser exited with error code: 0 15:53:21 INFO - 2015-11-23 15:53:21,486 INFO : Completed test v8_7 (00:00:39) 15:53:21 INFO - 2015-11-23 15:53:21,564 INFO : Completed test suite (00:20:10) 15:53:21 INFO - 2015-11-23 15:53:21,564 DEBUG : Working with test: dromaeo_css 15:53:21 INFO - 2015-11-23 15:53:21,564 DEBUG : Generating results file: dromaeo_css 15:53:21 INFO - 2015-11-23 15:53:21,565 DEBUG : Working with test: kraken 15:53:21 INFO - 2015-11-23 15:53:21,565 DEBUG : Generating results file: kraken 15:53:21 INFO - 2015-11-23 15:53:21,566 INFO : javascript benchmark 15:53:21 INFO - 2015-11-23 15:53:21,566 DEBUG : Working with test: v8_7 15:53:21 INFO - 2015-11-23 15:53:21,566 DEBUG : Generating results file: v8_7 15:53:21 INFO - 2015-11-23 15:53:21,566 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:53:21 INFO - 2015-11-23 15:53:21,618 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 15:53:21 INFO - 2015-11-23 15:53:21,618 DEBUG : process_Request line: dromaeo_css 7006.71 graph.html#tests=[[72,201,35]] 15:53:21 INFO - 2015-11-23 15:53:21,618 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:53:21 INFO - 2015-11-23 15:53:21,649 DEBUG : process_Request line: kraken 1496.90 graph.html#tests=[[232,201,35]] 15:53:21 INFO - 2015-11-23 15:53:21,649 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:53:21 INFO - 2015-11-23 15:53:21,685 DEBUG : process_Request line: v8_7 19404.02 graph.html#tests=[[230,201,35]] 15:53:21 INFO - 2015-11-23 15:53:21,686 INFO : javascript benchmark 15:53:21 INFO - 2015-11-23 15:53:21,690 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3184.9681503184966, 3217.501287300466, 3262.1355340834666, 3272.869085236589, 3284.573005509284, 5212.973935130329, 5334.786608535654, 5427.43011983742, 5428.587046727389, 5436.075867102592, 5369.5704343652515, 5393.59548033897, 5424.7830086796575, 5427.457254274571, 5461.836144915659, 4940.6047516198705, 4989.600831933437, 5005.224190250517, 5031.72325522098, 5042.5713814325645, 4802.255650374198, 5058.317127187837, 5084.161113416282, 5111.182210846266, 5149.047426226141, 4908.337374454439, 4938.654294199426, 5026.7486625668935, 5040.6471546991725, 5053.797848086072, 5004.799808007675, 5012.298278241013, 5013.448520662724, 5042.924356134661, 5095.414027386861, 4842.201036828919, 4952.603791696692, 4987.875303117415, 4998.500149985009, 5022.397312322508, 5161.122609156452, 5186.740662966874, 5198.818041368534, 5226.947730522684, 5227.18978558324, 5910.172575839386, 5925.0, 5931.940680593182, 5949.702514874239, 5950.5834591578605, 5572.442755724435, 5715.885682286331, 5766.481016708474, 5963.4334738199805, 5972.402759723993, 5490.094134467808, 5565.66606003637, 5571.693556854371, 5580.693061881636, 5592.748326325325, 6032.276126864805, 6039.758409663652, 6048.213732214872, 6056.0, 6113.38866113394, 5674.460926212003, 5716.171155182558, 5776.018076926933, 5847.649141051551, 5903.734331955073, 5958.404159584007, 5961.046232602849, 5961.225040744762, 5961.731722072517, 5970.34326224115, 5895.852603684943, 5922.8815423691285, 5947.940520594825, 5959.374265702126, 5959.910601340984, 5740.942590574041, 5826.883462330729, 5855.151003104526, 5904.557158213065, 5947.881042379128, 4494.056248187851, 4510.864674059783, 4537.8184872604725, 4539.205639013159, 4579.107074120581, 3953.2686453006286, 4031.697622678311, 4039.2931237033404, 4051.453053837753, 4085.673146148301, 5530.917036244459, 5582.97208513963, 5630.634008789416, 5654.434556544313, 5694.032014557535, 5875.764969401262, 5885.293764748258, 5885.970570147122, 5889.146073819272, 5895.911561326584, 5302.2576839241765, 5397.541208997201, 5564.638298510584, 5566.304211973504, 5567.2762540870235, 5007.098722229961, 5089.541941225308, 5100.132977393852, 5104.69371837691, 5113.846584602468, 6134.9079763803575, 6139.26328840542, 6139.84650383744, 6141.293751218667, 6150.538709596798, 5638.915416268677, 5697.8860422790485, 5748.54011679073, 5934.9406505934385, 5941.079132734433, 5824.70876456167, 5859.2090067842, 5868.2077919480325, 5880.794172204123, 5913.083472061838, 5742.569307301886, 5759.280089988752, 5808.099744539603, 5810.070388737781, 5823.82528524145, 5659.603827732019, 5790.913136302875, 5945.851353716019, 5958.344582096052, 5962.821115366546, 5568.053430916835, 5645.887082258414, 5676.0, 5685.545156387562, 5697.059985102412, 5707.8858422832145, 5757.337906140848, 5770.538356931519, 5774.653520788766, 5779.653220806765, 5373.086575282133, 5621.55027597783, 5669.546436285004, 5689.374168841507, 5691.601587888808, 5666.914996275142, 5693.800716975052, 5715.9142612860005, 5766.192733017297, 5785.132230165509, 5659.490645841894, 5692.686902220417, 5726.341470730919, 5736.512396446349, 5778.884422311614], "unit": "ms", "name": "dojo.html", "value": 5405.7333870479415}, {"lowerIsBetter": false, "replicates": [563.8477611045018, 612.3876123876124, 615.2862679292025, 618.7153909201768, 619.9969000154998, 30647.08058758238, 31515.842420787892, 39479.802600986994, 39847.20305593894, 40125.19749605006, 43316.78341608288, 43869.341959870624, 43922.34116488255, 43925.341119883145, 44015.0, 7326.413886889036, 7483.77548673538, 8605.95697021514, 8792.296616270714, 8797.516136612483, 10365.689029329133, 10558.630447934323, 10624.78750424991, 10630.096441802456, 10647.361158330525, 10316.742081447948, 10423.843642345333, 10426.165906727481, 10433.373997560133, 10436.530356133955, 7464.477486575942, 7581.052368453916, 7585.2035536269, 10095.545700443497, 10241.33431326965, 9773.0, 9892.208623310118, 9902.306838521306, 9915.851262231072, 9921.50392480373, 36533.45199822005, 36729.816350918074, 37068.44397334042, 37167.814160929294, 37293.0, 3307.9834600826844, 3307.9834600826844, 3353.6646335366268, 3454.5681789776277, 3626.2203626220225, 29577.408451830845, 30006.0, 30131.69868301311, 30273.243168920733, 30360.54459183114, 3747.8126093695205, 3796.354619714655, 3807.5240594925635, 3819.732618716691, 3824.1969186470874, 267982.0, 268322.0, 269614.0, 270369.999999998, 270433.0, 54895.0, 55688.0, 57712.4228757707, 58043.419565804645, 58345.124823127684, 66868.0, 67410.0, 67423.0, 67500.6624966872, 67688.32311676918, 15296.541103766682, 15367.385304587915, 15501.534953951399, 15517.146556939251, 15531.689366212839, 12350.505979760888, 12391.318477483825, 12406.62780116598, 12407.75184496305, 12414.565490207799, 19126.80873191278, 19159.137838797287, 19179.90410047941, 19244.326448574233, 19308.80691193098, 7265.2371500992695, 7415.073115860518, 7442.18136005039, 7460.328570428687, 7467.215942325977, 982.2436723722693, 983.0513554420019, 1000.3466547813656, 1066.1896958311738, 1122.859642544682, 27980.0, 28196.71803281982, 28340.71659283422, 29088.85455572751, 29097.0, 1007.4559737741538, 1009.5356136177294, 1077.902988731018, 1085.46812062089, 1115.252780636975, 13529.59411217665, 13717.588472345846, 13722.382492787849, 13888.791668124986, 13953.511627093003, 322963.0, 326728.0, 327378.0, 327850.0, 328335.0, 50636.74681626568, 50720.74639626852, 50892.236616450784, 51160.48839511557, 51174.74412627913, 1164.132721122752, 1280.7310464802497, 1343.8185844911006, 1394.6443656867434, 1444.111871199226, 26038.479230415665, 26085.0, 26316.07871742008, 26485.735142649097, 26613.0, 38863.61136388713, 39069.41395879121, 39124.6087539121, 39234.411483828335, 39412.408813867245, 297498.0, 305282.0, 305819.0, 372394.0, 376726.0, 30124.3975120492, 30213.395732085675, 30233.848830756586, 30317.84841075869, 30319.0, 38706.80646596749, 39263.41104883486, 39773.40339894846, 39849.2030159401, 39869.20261594694, 34953.126171845906, 35009.47485787766, 35295.11762205863, 36118.4582231272, 36128.819355903055, 35954.4606830903, 36265.456018159224, 36734.8163259182, 36764.080897977765, 36912.0, 35146.0, 35509.46735798913, 35615.0, 35670.28659426745, 35728.64271357357, 30526.847365763027, 32535.349293014482, 33355.332893342485, 33386.0, 33411.66588334086, 24092.87953560221, 24364.390890227885, 24409.51180976406, 24465.266042018768, 24764.0], "unit": "ms", "name": "ext.html", "value": 18512.7111751606}, {"lowerIsBetter": false, "replicates": [342.5341535511702, 348.69663392848224, 351.93137338219026, 352.67906205353125, 354.1942081763987, 14031.43874245029, 14417.06289091211, 16482.505524834243, 16653.417130400438, 17246.137693115343, 14912.25438728062, 15170.241487925614, 16432.424865129724, 16537.421190258345, 16570.917145414285, 5072.873178170538, 5337.492938170868, 5339.919901201485, 5344.438833922441, 5347.0909945309195, 4015.3575427931537, 4123.958760412387, 5317.574594032488, 5754.7410366533395, 5978.312494063195, 5875.76496940124, 5880.735366908478, 5884.176215329857, 5925.051991681332, 5931.436513531229, 5719.28508936383, 5883.646981181121, 5907.763689452417, 5931.792387266425, 5938.435848594377, 5195.766190521435, 5212.218167274901, 5215.191645294947, 5221.556167725748, 5232.450592687751, 10372.0, 10422.0, 15825.841741582552, 18247.908760456245, 18776.62446751071, 2134.082344591825, 2169.4142581503065, 2248.067052173346, 2335.0426325206754, 2403.9639405408934, 9642.75893102671, 9719.271054670857, 9737.707868763877, 9826.557804898797, 9884.0, 1870.2425517665367, 1873.5409824592925, 1886.1135266424758, 1902.9714554281697, 1903.6478251523513, 58077.0, 60039.0, 60854.0, 61291.387086129456, 62117.0, 9407.764805879771, 9746.75633109178, 9795.706128816148, 9881.456519891475, 9907.504624768733, 12703.682407939876, 12787.593364729872, 12812.487500500061, 12829.550965716342, 12854.164479308814, 7764.3788496920115, 7791.883121753178, 7868.291853733077, 7874.842503149905, 7888.2506161914525, 7657.923420765833, 7682.347000504908, 7717.421193410517, 7773.183815699384, 7827.373810095179, 4367.475902891673, 4367.92985718501, 4447.599716025573, 4501.7974191161475, 4516.277395616686, 1704.0457343887215, 1792.3637108826179, 1795.8024617292087, 1816.554944038719, 1852.0832188066993, 834.3033566971525, 854.8546747053016, 910.2490445382585, 914.5792935249859, 962.5572236771023, 13810.723785524233, 15478.226088695521, 15559.611009724847, 15929.840701593068, 16158.111303878164, 893.0578239956908, 910.5674804467957, 919.5999740113073, 951.743029382063, 951.8239125761618, 8932.79407280022, 9468.952655236817, 9945.403275803475, 10137.0, 10209.0, 485311.0, 488710.0, 491133.0, 491899.0, 497513.0, 76008.61995690096, 76425.23574764292, 77287.0, 78958.21041789623, 79551.0, 1169.8947094761513, 1176.16492290473, 1179.0862081886435, 1188.744419949715, 1190.0598527163445, 15123.697526049638, 15291.0, 15316.617084572976, 15437.768433473731, 15580.143092130042, 34285.48571771475, 34800.129996750285, 35017.0, 35375.82312088423, 35910.28179436344, 45381.09237815159, 46288.30567541557, 46456.53543464522, 47916.520834791205, 48992.5100748988, 9461.148496635336, 9713.417194968324, 9804.705858824247, 9852.802943941224, 9855.408675479493, 11594.826077609012, 16014.599635009217, 17533.561660958578, 17676.91161544184, 17873.0, 14546.709065818835, 14623.268836558342, 14756.557303280919, 15021.02363346379, 15083.491650834829, 13990.510332138327, 14339.350974637633, 14465.566033019026, 14732.484363047242, 14841.554753357417, 14745.336459859547, 14950.401983920521, 15087.39650414015, 15248.3900643973, 15339.23303834826, 9561.282903782383, 9684.903150968401, 9750.853737193806, 9762.17021553176, 9766.316357854881, 14418.42326306936, 14591.124532528082, 14681.412743490568, 14929.02961307555, 14939.0], "unit": "ms", "name": "jquery.html", "value": 8792.589834235087}, {"lowerIsBetter": false, "replicates": [1349.2579081505169, 1668.3743596151446, 1734.1415999080457, 1744.3197153110282, 1771.362309568556, 6684.866302673943, 7152.713891444342, 7422.4062075034, 7437.44219183562, 7440.739574114907, 7539.39684825214, 7641.923580764191, 7646.885296720539, 7649.885251721229, 7662.501937374081, 1972.4970132616163, 1996.980030199701, 1998.9200431982777, 2226.6326056200705, 2251.6397376419777, 2004.9097790599385, 2236.8769717665523, 2281.030562011147, 2283.098176220392, 2287.0623044551735, 2201.5816994770944, 2244.147224054857, 2251.133313674239, 2279.2022792022744, 2284.314705588325, 2000.1699294792788, 2050.3438899552148, 2223.83321250906, 2232.966505502419, 2236.8322375821876, 2193.484531135182, 2241.4396400899777, 2243.0242844362756, 2243.461569223391, 2244.259394399844, 7556.622168891588, 7682.270184332479, 7684.423668224906, 7691.961540192263, 7693.730719424793, 4653.208954477747, 4716.976415117937, 4749.643776716725, 4753.595944344735, 4755.785989630475, 3037.104054303986, 3194.6166460024715, 3214.4053350130066, 3220.1788543921384, 3238.3685181389637, 970.5486948568949, 971.8299297622958, 990.2622546203053, 1008.500792107904, 1043.8434234864756, 10555.0, 10558.577656893714, 10565.3132546385, 10581.259311848175, 10601.469926503722, 4204.957950420457, 4269.124829409963, 4321.308590625485, 4323.308270676676, 4334.45819272591, 9063.81872362549, 9065.320100992452, 9082.0, 9089.636414543476, 9106.772330691785, 4681.110588988149, 4689.437267527918, 4692.202325604655, 4706.764661766898, 4718.009218064176, 4255.212785634668, 4255.97872010638, 4256.318988961813, 4257.552956939477, 4263.936040959388, 3642.763220390666, 3668.284684486553, 3684.907877303035, 3712.406015037581, 3727.9068023299633, 1198.287019223578, 1209.8185272209064, 1210.8546974362957, 1212.4240985531978, 1213.205350495427, 1325.2578556008666, 1330.314887832767, 1349.156777014366, 1364.8157498737544, 1365.8975576831579, 7193.784186474414, 7295.52579082358, 7348.559086454829, 7354.521956072838, 7363.263673632594, 1105.6959336182454, 1109.5561775289948, 1114.2200459678259, 1122.3826895207603, 1126.723952631594, 5511.366192887869, 5613.635113717595, 5786.189933409326, 5840.561957853178, 5955.196048533479, 8699.434536755218, 8796.296296296281, 8899.065598112235, 8901.198892099612, 8917.687880924137, 8904.688335908342, 8968.461892286483, 9063.501507417024, 9082.0, 9117.498537580497, 7016.824579385556, 7034.19106802714, 7120.71517139319, 7174.282571742784, 7182.928170718226, 6969.059177011241, 7029.613371264425, 7031.156261248479, 7033.120859892513, 7036.648167591497, 8157.55133467665, 8219.917800822155, 8258.504489730636, 8333.458325208841, 8344.207300306462, 8217.79455513617, 8385.664573416994, 8505.277051450448, 8561.657533698582, 8608.139186081342, 6527.5430719849155, 6575.901361479678, 6651.06885036105, 6674.8998765017595, 6759.222689390783, 7415.1101867776215, 7496.362809161283, 7500.62496875165, 7502.062242219723, 7504.699812007459, 7097.82255443618, 7109.502334836512, 7116.822079447848, 7219.169795473378, 7222.09723784527, 6948.687309071205, 7001.194862590867, 7044.859102818017, 7062.788116356517, 7091.11361079865, 6340.461060809883, 6770.187577490733, 6853.314668533107, 6891.793246202622, 6901.240863505111, 6328.177336946167, 6412.647304398303, 6439.581427207404, 6444.7744328948265, 6464.806055818333, 6507.023946408077, 6544.4764418845425, 6589.47284217271, 6593.967030164818, 6608.801735947929], "unit": "ms", "name": "mootools.html", "value": 4461.663384013269}, {"lowerIsBetter": false, "replicates": [337.91889946412863, 340.8755804131491, 348.2008789827344, 348.39031694534566, 348.95463589733333, 5839.532837373011, 5999.850003749903, 6010.909836352453, 6012.939870601287, 6035.486983606399, 5779.62432441891, 5936.821895343136, 5951.375105613914, 5961.821145365635, 5964.582479226456, 4609.3777340059, 4612.561806628365, 4617.0, 4617.122746678137, 4625.236835922077, 4429.335599660045, 4479.462464504264, 4517.344984977176, 4537.818487260505, 4623.283391074388, 4488.079943611552, 4490.438695163105, 4506.7070640408265, 4517.390152329426, 4527.230370836949, 4487.618552423048, 4496.7077139985795, 4506.391637128995, 4508.549145085498, 4549.45406551216, 3956.188981258835, 3978.900527486807, 3983.342748446503, 3992.2215168042244, 3995.6603688686496, 5501.834944951658, 5662.122371032497, 5665.49010589049, 5683.261176047087, 5688.914666280009, 5306.044911915854, 5310.203469479609, 5311.1767676009895, 5312.574994000471, 5313.867153321159, 5991.400859914017, 6336.968315158395, 6340.429361357454, 6344.809655710336, 6350.364963503659, 4191.119864828359, 4308.332208507686, 4390.8024138913825, 4394.912101757979, 4410.603045725868, 6416.45460135889, 6507.089007538948, 6515.087887695727, 6517.902231466532, 6519.837004074936, 4461.08547747711, 4464.598186163261, 4464.910701785946, 4472.798724057425, 4473.597376236155, 4434.689571729948, 4501.437320334958, 4521.4574251089425, 4538.523455037173, 4545.749983750859, 5240.9213861792105, 5247.868803279948, 5251.474852514794, 5253.133233016586, 5255.290535777621, 6322.4942004639515, 6330.4619107375465, 6340.651264180515, 6346.904796428057, 6347.5556711029785, 1587.3650539783948, 1613.9112348820927, 1619.684161588479, 1620.440947872982, 1626.8698504119643, 1067.887871773468, 1071.6999240212754, 1075.7848430313968, 1091.2797553614575, 1097.2538673701958, 6137.723802428812, 6142.692865356715, 6143.723532440961, 6151.938480615226, 6162.969185154046, 6522.869542609121, 6530.869382612416, 6537.019447082976, 6540.4767618590395, 6540.509461790385, 6002.39976002405, 6134.263888333428, 6144.9553575892205, 6146.385361463817, 6157.107219453154, 3523.6652518010746, 3542.00823769345, 3544.8759293424605, 3551.5915669697797, 3553.129483276562, 6699.866002679919, 6735.02342160384, 6738.393544581011, 6753.898691519631, 6755.594664320157, 6554.213494380705, 6654.0, 6681.33186681328, 6716.529842910949, 6724.159480064992, 6700.49746269022, 6709.865802683919, 6720.865582688417, 6725.529212955144, 6731.932680673229, 6367.681615919279, 6489.318621544669, 6516.348365163446, 6525.086487891794, 6528.183977002875, 6392.616443013434, 6452.548321617442, 6528.053432252202, 6544.443722283469, 6562.146920900444, 6750.257471678014, 6763.289854565397, 6776.08522849409, 6776.254611992776, 6787.151606049244, 4380.123975204908, 4435.955640443554, 4437.33439984005, 4449.710768800018, 4453.421055262925, 6568.8357791055605, 6575.736970521126, 6587.341265873374, 6587.901181482186, 6588.209414870054, 6406.455451286693, 6413.1021656969, 6416.550841441054, 6417.358264173732, 6418.390252925965, 6226.034964580497, 6365.427111559982, 6372.299047104722, 6399.0, 6402.775902843378, 6249.937500624936, 6251.0623406487575, 6259.436650701458, 6259.6870156492905, 6261.24865016201, 6389.968050159905, 6398.488120950406, 6398.5521013528605, 6406.13517175194, 6409.7436102555375, 6136.2636483622255, 6241.656708881055, 6247.656378899204, 6248.187735594343, 6293.307736149111], "unit": "ms", "name": "prototype.html", "value": 4778.173864033956}, {"lowerIsBetter": false, "replicates": [736.7384578474645, 738.1253214940297, 746.4588173574156, 762.4434163060965, 844.9155084491549, 13986.580402587913, 14317.856821431782, 14359.78460323096, 14395.280235988197, 14407.711845763104, 13434.261115638636, 13550.93224533876, 13559.457621695145, 13578.117422367539, 13582.524611638595, 681.2336121862904, 683.8700646877103, 809.1746418652971, 813.5525460996444, 831.6465502161587, 824.1223097401248, 824.8803923431099, 830.339879795564, 830.8255266394034, 831.3930830493744, 703.9331263529982, 860.0754189246554, 865.312076898867, 866.2030931542964, 866.2290561400358, 697.9022936788854, 846.7121178799207, 851.3742399336545, 856.1609622569854, 860.1699360117517, 637.0, 638.9329120442379, 638.9616623002588, 639.434100820777, 639.7984634840057, 13140.60578182656, 13291.268980206085, 13296.26870522121, 13299.468021279137, 13315.467381304736, 12318.876811231863, 12784.232946023176, 12939.48242070316, 12942.288174150419, 12996.610101696964, 10304.94847525765, 10412.479376031244, 10531.26281160319, 10623.575056997788, 10637.0, 3608.7293452990866, 3657.3416784978695, 3689.6863766579872, 3721.925561488782, 3769.076576238839, 47378.76310618459, 48535.75732121352, 48581.51418485805, 48634.0, 48808.0, 9561.229869393543, 9755.317127801127, 9821.558029888673, 9889.10998010168, 10206.193222604461, 17767.555811104827, 17771.644567108586, 17786.91106544459, 17816.376426824998, 17830.19764110618, 7569.962150189213, 7604.619769011527, 7684.577348245788, 7746.961265193638, 7829.0, 4160.084781348099, 4227.957720422756, 4322.891927701769, 4339.956600433955, 4442.20040392726, 3098.860551275198, 3116.423461659555, 3117.6570577236484, 3117.828519431453, 3121.1572875323536, 526.9183276592134, 542.8073034072926, 556.6715637773733, 557.3423360434726, 557.9079451890393, 534.6765207049757, 593.2488283335613, 619.5910698938679, 641.9311845776823, 671.6574546981075, 9082.40964337316, 9381.5309234538, 9440.197583205505, 9570.138687518156, 9659.90340096604, 534.5029122915726, 651.775137577535, 688.3391943734072, 705.3792662457005, 717.6304203335286, 4062.2354670877603, 4126.8761937141935, 4220.810063547147, 4311.396404503372, 4417.884857879046, 54058.729706352, 54464.45535544594, 54738.45261547413, 54742.17886731702, 54804.72597637066, 48012.279815802794, 48290.27564586534, 48416.0, 49905.25142122871, 50061.0, 44729.32906006347, 45418.77290613526, 45436.3184552232, 45682.0, 46275.30587041197, 8385.371097167616, 8404.663813447638, 8498.0, 8544.273736732199, 8577.785555360917, 33131.50302745509, 33341.33317333688, 33745.83127084349, 33829.32341353208, 34334.14164645904, 39511.0, 39843.60156398515, 41074.58925410827, 43783.78108109439, 43898.0, 11248.550057997589, 11468.369239691898, 11478.368689722145, 11557.826632600685, 11996.820047699117, 12168.695782605506, 12420.192687475284, 12526.311052892179, 12740.108192426442, 12807.295598741786, 11235.49440275206, 11520.251183673034, 11678.06575473977, 11832.881671183179, 11919.404029798301, 11450.94274528622, 11701.941490292495, 11917.22538035025, 11941.761164776482, 12342.13605047638, 7813.645500768486, 10946.835797462885, 11078.224524283223, 11965.940170299093, 12191.695207619881, 9431.339806213773, 9585.616575336908, 9652.469114198506, 9654.810835942508, 9789.118979291898, 9691.612335506783, 9856.950715246378, 9869.753256168653, 9978.452673013242, 10073.093421592092], "unit": "ms", "name": "yui.html", "value": 6307.352137114554}], "name": "dromaeo_css", "value": 7006.712162984406}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 110.0, 102.0, 109.0, 109.0, 111.0, 97.0, 108.0, 110.0, 99.0], "unit": "ms", "name": "ai-astar", "value": 106.2}, {"lowerIsBetter": true, "replicates": [153.0, 123.0, 145.0, 165.0, 129.0, 152.0, 157.0, 125.0, 160.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.4}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 162.0, 163.0, 163.0, 164.0, 162.0, 163.0, 166.0, 165.0], "unit": "ms", "name": "audio-dft", "value": 163.5}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 83.0, 92.0, 71.0, 74.0, 72.0, 99.0, 97.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.4}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 143.0, 92.0, 93.0, 93.0, 142.0, 93.0, 94.0, 138.0], "unit": "ms", "name": "audio-oscillator", "value": 107.4}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 145.0, 144.0, 144.0, 146.0, 145.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.1}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 59.0, 57.0, 59.0, 56.0, 64.0, 58.0, 60.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 58.5}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 69.0, 70.0, 69.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 86.0, 84.0, 91.0, 83.0, 83.0, 84.0, 86.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [114.0, 115.0, 121.0, 116.0, 122.0, 118.0, 120.0, 130.0, 123.0, 118.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 119.7}, {"lowerIsBetter": true, "replicates": [144.0, 148.0, 149.0, 149.0, 152.0, 139.0, 161.0, 150.0, 142.0, 140.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.4}, {"lowerIsBetter": true, "replicates": [69.0, 66.0, 65.0, 67.0, 67.0, 66.0, 65.0, 66.0, 67.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1496.9000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [186.25442354255912], "unit": "score", "name": "Richards", "value": 189.53643799999998}, {"lowerIsBetter": false, "replicates": [194.02405898331392], "unit": "score", "name": "DeltaBlue", "value": 340.772172}, {"lowerIsBetter": false, "replicates": [283.84899233607723], "unit": "score", "name": "Encrypt", "value": 937.7556629999997}, {"lowerIsBetter": false, "replicates": [5010.0], "unit": "score", "name": "Decrypt", "value": 53.12994011976049}, {"lowerIsBetter": false, "replicates": [1951.2670565302144], "unit": "score", "name": "RayTrace", "value": 379.23512187812196}, {"lowerIsBetter": false, "replicates": [781.25], "unit": "score", "name": "Earley", "value": 853.0726399999998}, {"lowerIsBetter": false, "replicates": [12456.79012345679], "unit": "score", "name": "Boyer", "value": 53.501985133795806}, {"lowerIsBetter": false, "replicates": [25525.0], "unit": "score", "name": "RegExp", "value": 35.689911851126354}, {"lowerIsBetter": false, "replicates": [683.7270341207349], "unit": "score", "name": "Splay", "value": 119.18645297504803}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19404.015075167023}]} 15:53:21 INFO - RETURN: dromaeo_css: 7006.71 15:53:21 INFO - RETURN: kraken: 1496.90 15:53:21 INFO - RETURN: v8_7: 19404.02 15:53:21 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19404.02"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1496.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "7006.71"}}} 15:53:21 INFO - Return code: 0 15:53:21 INFO - # TBPL SUCCESS # 15:53:21 INFO - Running post-action listener: _resource_record_post_action 15:53:21 INFO - Running post-run listener: _resource_record_post_run 15:53:22 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 4096; Write bytes: 513601536; Read time: 52; Write time: 558040 15:53:22 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 242438144; Read time: 0; Write time: 422272 15:53:22 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 271151104; Read time: 52; Write time: 135768 15:53:22 INFO - Running post-run listener: _upload_blobber_files 15:53:22 INFO - Blob upload gear active. 15:53:22 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 15:53:22 INFO - Copying logs to upload dir... 15:53:22 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1255.322511 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2015-11-23 15:53:22.092623) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 15:53:22.096558) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1448318115.326639-59100879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/FTp9ZoacSoG0DVJxV0fHEA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009933 build_url: 'https://queue.taskcluster.net/v1/task/FTp9ZoacSoG0DVJxV0fHEA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 15:53:22.151369) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:53:22.152005) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1448318115.326639-59100879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004664 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:53:22.204985) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 15:53:22.205548) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 15:53:22.206125) ========= ========= Total master_lag: 0.23 =========