builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1448052515.17 results: success (0) buildid: 20151120113004 builduid: b3919375835644538d0bbf07b7d23232 revision: 106bfad77bf44d39fc334b336b037a70c2130d52 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 12:48:35.169960) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 12:48:35.170819) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 12:48:35.171340) ========= 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=6587686cb2da90a5f91b3170000001be-1448052444.742510-424514314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006715 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 12:48:35.193003) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 12:48:35.193327) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 12:48:35.219547) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 12:48:35.219832) ========= 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=6587686cb2da90a5f91b3170000001be-1448052444.742510-424514314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004703 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 12:48:35.270375) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 12:48:35.270640) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 12:48:35.271266) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 12:48:35.271551) ========= 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=6587686cb2da90a5f91b3170000001be-1448052444.742510-424514314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 12:48:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 220M=0s 2015-11-20 12:48:35 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.197232 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 12:48:35.480696) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 12:48:35.480998) ========= 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=6587686cb2da90a5f91b3170000001be-1448052444.742510-424514314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017804 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 12:48:35.529743) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 12:48:35.530111) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 106bfad77bf44d39fc334b336b037a70c2130d52 --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 106bfad77bf44d39fc334b336b037a70c2130d52 --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=6587686cb2da90a5f91b3170000001be-1448052444.742510-424514314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 12:48:35,712 truncating revision to first 12 chars 2015-11-20 12:48:35,713 Setting DEBUG logging. 2015-11-20 12:48:35,713 attempt 1/10 2015-11-20 12:48:35,713 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/106bfad77bf4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 12:48:36,017 unpacking tar archive at: b2g-inbound-106bfad77bf4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.601482 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 12:48:36.143807) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 12:48:36.144111) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 12:48:36.153893) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 12:48:36.154173) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 12:48:36.154549) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2015-11-20 12:48:36.154839) ========= /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=6587686cb2da90a5f91b3170000001be-1448052444.742510-424514314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:48:36 INFO - MultiFileLogger online at 20151120 12:48:36 in /builds/slave/test-pgo 12:48:36 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 12:48:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 12:48:36 INFO - {'append_to_log': False, 12:48:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 12:48:36 INFO - 'blob_upload_branch': 'B2G-Inbound', 12:48:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 12:48:36 INFO - 'branch': 'B2G-Inbound', 12:48:36 INFO - 'buildbot_json_path': 'buildprops.json', 12:48:36 INFO - 'config_files': ('talos/linux_config.py',), 12:48:36 INFO - 'default_actions': ('clobber', 12:48:36 INFO - 'read-buildbot-config', 12:48:36 INFO - 'download-and-extract', 12:48:36 INFO - 'populate-webroot', 12:48:36 INFO - 'create-virtualenv', 12:48:36 INFO - 'install', 12:48:36 INFO - 'run-tests'), 12:48:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:48:36 INFO - 'download_minidump_stackwalk': True, 12:48:36 INFO - 'download_symbols': 'ondemand', 12:48:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:48:36 INFO - 'tooltool.py': '/tools/tooltool.py', 12:48:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:48:36 INFO - '/tools/misc-python/virtualenv.py')}, 12:48:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:48:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:48:36 INFO - 'installer_path': 'installer.exe', 12:48:36 INFO - 'log_level': 'info', 12:48:36 INFO - 'log_name': 'talos', 12:48:36 INFO - 'log_to_console': True, 12:48:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:48:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:48:36 INFO - 'opt_config_files': (), 12:48:36 INFO - 'pip_index': False, 12:48:36 INFO - 'sps_profile': False, 12:48:36 INFO - 'sps_profile_interval': 0, 12:48:36 INFO - 'suite': 'dromaeojs', 12:48:36 INFO - 'system_bits': '64', 12:48:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:48:36 INFO - 'title': 'talos-linux64-ix-017', 12:48:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:48:36 INFO - 'use_talos_json': True, 12:48:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 12:48:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:48:36 INFO - 'work_dir': 'build'} 12:48:36 INFO - ##### 12:48:36 INFO - ##### Running clobber step. 12:48:36 INFO - ##### 12:48:36 INFO - Running pre-action listener: _resource_record_pre_action 12:48:36 INFO - Running main action method: clobber 12:48:36 INFO - rmtree: /builds/slave/test-pgo/build 12:48:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 12:48:36 INFO - Running post-action listener: _resource_record_post_action 12:48:36 INFO - ##### 12:48:36 INFO - ##### Running read-buildbot-config step. 12:48:36 INFO - ##### 12:48:36 INFO - Running pre-action listener: _resource_record_pre_action 12:48:36 INFO - Running main action method: read_buildbot_config 12:48:36 INFO - Using buildbot properties: 12:48:36 INFO - { 12:48:36 INFO - "properties": { 12:48:36 INFO - "buildnumber": 986, 12:48:36 INFO - "product": "firefox", 12:48:36 INFO - "script_repo_revision": "production", 12:48:36 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 12:48:36 INFO - "repository": "", 12:48:36 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 12:48:36 INFO - "buildid": "20151120113004", 12:48:36 INFO - "slavename": "talos-linux64-ix-017", 12:48:36 INFO - "pgo_build": "True", 12:48:36 INFO - "basedir": "/builds/slave/test-pgo", 12:48:36 INFO - "project": "", 12:48:36 INFO - "platform": "ubuntu64_hw", 12:48:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:48:36 INFO - "slavebuilddir": "test", 12:48:36 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 12:48:36 INFO - "branch": "b2g-inbound", 12:48:36 INFO - "repo_path": "integration/b2g-inbound", 12:48:36 INFO - "stage_platform": "linux64-pgo", 12:48:36 INFO - "builduid": "b3919375835644538d0bbf07b7d23232", 12:48:36 INFO - "revision": "106bfad77bf44d39fc334b336b037a70c2130d52" 12:48:36 INFO - }, 12:48:36 INFO - "sourcestamp": { 12:48:36 INFO - "repository": "", 12:48:36 INFO - "hasPatch": false, 12:48:36 INFO - "project": "", 12:48:36 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 12:48:36 INFO - "changes": [ 12:48:36 INFO - { 12:48:36 INFO - "category": null, 12:48:36 INFO - "files": [ 12:48:36 INFO - { 12:48:36 INFO - "url": null, 12:48:36 INFO - "name": "https://queue.taskcluster.net/v1/task/WCICnORvQFCwGij-EsGXSA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 12:48:36 INFO - } 12:48:36 INFO - ], 12:48:36 INFO - "repository": "", 12:48:36 INFO - "rev": "106bfad77bf44d39fc334b336b037a70c2130d52", 12:48:36 INFO - "who": "sendchange", 12:48:36 INFO - "when": 1448052442, 12:48:36 INFO - "number": 6690450, 12:48:36 INFO - "comments": "", 12:48:36 INFO - "project": "", 12:48:36 INFO - "at": "Fri 20 Nov 2015 12:47:22", 12:48:36 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 12:48:36 INFO - "revlink": "", 12:48:36 INFO - "properties": [ 12:48:36 INFO - [ 12:48:36 INFO - "buildid", 12:48:36 INFO - "20151120113004", 12:48:36 INFO - "Change" 12:48:36 INFO - ], 12:48:36 INFO - [ 12:48:36 INFO - "builduid", 12:48:36 INFO - "b3919375835644538d0bbf07b7d23232", 12:48:36 INFO - "Change" 12:48:36 INFO - ], 12:48:36 INFO - [ 12:48:36 INFO - "pgo_build", 12:48:36 INFO - "True", 12:48:36 INFO - "Change" 12:48:36 INFO - ] 12:48:36 INFO - ], 12:48:36 INFO - "revision": "106bfad77bf44d39fc334b336b037a70c2130d52" 12:48:36 INFO - } 12:48:36 INFO - ], 12:48:36 INFO - "revision": "106bfad77bf44d39fc334b336b037a70c2130d52" 12:48:36 INFO - } 12:48:36 INFO - } 12:48:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/WCICnORvQFCwGij-EsGXSA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 12:48:36 INFO - Running post-action listener: _resource_record_post_action 12:48:36 INFO - ##### 12:48:36 INFO - ##### Running download-and-extract step. 12:48:36 INFO - ##### 12:48:36 INFO - Running pre-action listener: _resource_record_pre_action 12:48:36 INFO - Running main action method: download_and_extract 12:48:36 INFO - mkdir: /builds/slave/test-pgo/build/tests 12:48: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')]} 12:48:36 INFO - https://queue.taskcluster.net/v1/task/WCICnORvQFCwGij-EsGXSA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:48:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCICnORvQFCwGij-EsGXSA/artifacts/public/build/test_packages.json 12:48:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCICnORvQFCwGij-EsGXSA/artifacts/public/build/test_packages.json 12:48:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCICnORvQFCwGij-EsGXSA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 12:48:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCICnORvQFCwGij-EsGXSA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 12:48:37 INFO - Downloaded 1302 bytes. 12:48:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 12:48:37 INFO - Using the following test package requirements: 12:48:37 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:48:37 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:48:37 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:37 INFO - u'jsshell-linux-x86_64.zip'], 12:48:37 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:48:37 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:48:37 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:48:37 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:48:37 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:48:37 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:48:37 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:48:37 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:48:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:37 INFO - https://queue.taskcluster.net/v1/task/WCICnORvQFCwGij-EsGXSA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:48:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCICnORvQFCwGij-EsGXSA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:48:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCICnORvQFCwGij-EsGXSA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:48:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCICnORvQFCwGij-EsGXSA/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 12:48:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCICnORvQFCwGij-EsGXSA/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 12:48:38 INFO - Downloaded 22525095 bytes. 12:48:38 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 12:48:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:48:38 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 12:48:39 INFO - Return code: 0 12:48:39 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 12:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:39 INFO - https://queue.taskcluster.net/v1/task/WCICnORvQFCwGij-EsGXSA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:48:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCICnORvQFCwGij-EsGXSA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:48:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCICnORvQFCwGij-EsGXSA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:48:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCICnORvQFCwGij-EsGXSA/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 12:48:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCICnORvQFCwGij-EsGXSA/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 12:48:41 INFO - Downloaded 22525095 bytes. 12:48:41 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 12:48:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:48:41 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 12:48:42 INFO - Return code: 0 12:48:42 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')]} 12:48:42 INFO - https://queue.taskcluster.net/v1/task/WCICnORvQFCwGij-EsGXSA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:48:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCICnORvQFCwGij-EsGXSA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:48:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCICnORvQFCwGij-EsGXSA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:48:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCICnORvQFCwGij-EsGXSA/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 12:48:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCICnORvQFCwGij-EsGXSA/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 12:48:45 INFO - Downloaded 11130997 bytes. 12:48:45 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 12:48:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:48:45 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 12:48:45 INFO - Return code: 0 12:48: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')]} 12:48:45 INFO - https://queue.taskcluster.net/v1/task/WCICnORvQFCwGij-EsGXSA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:48:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCICnORvQFCwGij-EsGXSA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:48:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCICnORvQFCwGij-EsGXSA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:48:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCICnORvQFCwGij-EsGXSA/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 12:48:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCICnORvQFCwGij-EsGXSA/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 12:48:46 INFO - Downloaded 57344712 bytes. 12:48:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WCICnORvQFCwGij-EsGXSA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:48:46 INFO - mkdir: /builds/slave/test-pgo/properties 12:48:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 12:48:46 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 12:48:46 INFO - Contents: 12:48:46 INFO - build_url:https://queue.taskcluster.net/v1/task/WCICnORvQFCwGij-EsGXSA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:48:46 INFO - Running post-action listener: _resource_record_post_action 12:48:46 INFO - Running post-action listener: set_extra_try_arguments 12:48:46 INFO - ##### 12:48:46 INFO - ##### Running populate-webroot step. 12:48:46 INFO - ##### 12:48:46 INFO - Running pre-action listener: _resource_record_pre_action 12:48:46 INFO - Running main action method: populate_webroot 12:48:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:48:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:48:46 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:48:46 INFO - '../fennec_ids.txt'], 12:48:46 INFO - 'tests': ['tcheck2']}, 12:48:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:48:46 INFO - '--tppagecycles', 12:48:46 INFO - '7'], 12:48:46 INFO - 'tests': ['tsvgm']}}, 12:48:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:48:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:48:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:48:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:48:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:48:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:48:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:48:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:46 INFO - 'talos_options': ['--e10s'], 12:48:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:48:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:46 INFO - 'tests': ['damp', 'tps']}, 12:48:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:46 INFO - 'talos_options': ['--e10s'], 12:48:46 INFO - 'tests': ['damp', 'tps']}, 12:48:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:48:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:48:46 INFO - 'other': {'tests': ['a11yr', 12:48:46 INFO - 'ts_paint', 12:48:46 INFO - 'tpaint', 12:48:46 INFO - 'sessionrestore', 12:48:46 INFO - 'sessionrestore_no_auto_restore']}, 12:48:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:48:46 INFO - 'tests': ['a11yr', 12:48:46 INFO - 'ts_paint', 12:48:46 INFO - 'tpaint', 12:48:46 INFO - 'sessionrestore', 12:48:46 INFO - 'sessionrestore_no_auto_restore']}, 12:48:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:48:46 INFO - 'tests': ['a11yr', 12:48:46 INFO - 'ts_paint', 12:48:46 INFO - 'tpaint', 12:48:46 INFO - 'sessionrestore', 12:48:46 INFO - 'sessionrestore_no_auto_restore']}, 12:48:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:48:46 INFO - 'tests': ['a11yr', 12:48:46 INFO - 'ts_paint', 12:48:46 INFO - 'tpaint', 12:48:46 INFO - 'sessionrestore', 12:48:46 INFO - 'sessionrestore_no_auto_restore']}, 12:48:46 INFO - 'other_l64': {'tests': ['a11yr', 12:48:46 INFO - 'ts_paint', 12:48:46 INFO - 'tpaint', 12:48:46 INFO - 'sessionrestore', 12:48:46 INFO - 'sessionrestore_no_auto_restore']}, 12:48:46 INFO - 'other_nol64': {'tests': ['a11yr', 12:48:46 INFO - 'ts_paint', 12:48:46 INFO - 'tpaint', 12:48:46 INFO - 'sessionrestore', 12:48:46 INFO - 'sessionrestore_no_auto_restore']}, 12:48:46 INFO - 'svgr': {'tests': ['tsvgx', 12:48:46 INFO - 'tsvgr_opacity', 12:48:46 INFO - 'tart', 12:48:46 INFO - 'tscrollx', 12:48:46 INFO - 'cart']}, 12:48:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:48:46 INFO - 'tests': ['tsvgx', 12:48:46 INFO - 'tsvgr_opacity', 12:48:46 INFO - 'tart', 12:48:46 INFO - 'tscrollx', 12:48:46 INFO - 'cart']}, 12:48:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:46 INFO - 'tests': ['tp5o']}, 12:48:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:46 INFO - 'talos_options': ['--e10s'], 12:48:46 INFO - 'tests': ['tp5o']}, 12:48:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:46 INFO - 'talos_options': ['--xperf_path', 12:48:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:48:46 INFO - 'tests': ['tp5n']}, 12:48:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:46 INFO - 'talos_options': ['--e10s', 12:48:46 INFO - '--xperf_path', 12:48:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:48:46 INFO - 'tests': ['tp5n']}}, 12:48:46 INFO - 'talos.zip': {'path': '', 12:48:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:48:46 INFO - Running post-action listener: _resource_record_post_action 12:48:46 INFO - ##### 12:48:46 INFO - ##### Running create-virtualenv step. 12:48:46 INFO - ##### 12:48:46 INFO - Running pre-action listener: _resource_record_pre_action 12:48:46 INFO - Running main action method: create_virtualenv 12:48:46 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 12:48:46 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 12:48:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 12:48:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:48:46 INFO - Using real prefix '/usr' 12:48:46 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 12:48:47 INFO - Installing distribute.............................................................................................................................................................................................done. 12:48:49 INFO - Installing pip.................done. 12:48:49 INFO - Return code: 0 12:48:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 12:48:49 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')]} 12:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:49 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')]} 12:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:49 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 0x7f936e822c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14017c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1445d70>, '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 0x1446b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1446fb0>, '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': '6587686cb2da90a5f91b3170000001be-1448052444.742510-424514314', '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 12:48:49 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 12:48:49 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 12:48:49 INFO - Using env: {'DISPLAY': ':0', 12:48:49 INFO - 'HOME': '/home/cltbld', 12:48:49 INFO - 'LANG': 'en_US.UTF-8', 12:48:49 INFO - 'LANGUAGE': 'en_US:en', 12:48:49 INFO - 'LOGNAME': 'cltbld', 12:48:49 INFO - 'MAIL': '/var/mail/cltbld', 12:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:49 INFO - 'MOZ_NO_REMOTE': '1', 12:48:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:49 INFO - 'NO_EM_RESTART': '1', 12:48:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:48:49 INFO - 'PWD': '/builds/slave/test-pgo', 12:48:49 INFO - 'SHELL': '/bin/bash', 12:48:49 INFO - 'SHLVL': '1', 12:48:49 INFO - 'TERM': 'linux', 12:48:49 INFO - 'TMOUT': '86400', 12:48:49 INFO - 'USER': 'cltbld', 12:48:49 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448052444.742510-424514314', 12:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:49 INFO - '_': '/tools/buildbot/bin/python'} 12:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:49 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 12:48:49 INFO - Cleaning up... 12:48:49 INFO - Return code: 0 12:48:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 12:48:49 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')]} 12:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:49 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')]} 12:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:49 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 0x7f936e822c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14017c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1445d70>, '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 0x1446b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1446fb0>, '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': '6587686cb2da90a5f91b3170000001be-1448052444.742510-424514314', '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 12:48:49 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 12:48:49 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 12:48:49 INFO - Using env: {'DISPLAY': ':0', 12:48:49 INFO - 'HOME': '/home/cltbld', 12:48:49 INFO - 'LANG': 'en_US.UTF-8', 12:48:49 INFO - 'LANGUAGE': 'en_US:en', 12:48:49 INFO - 'LOGNAME': 'cltbld', 12:48:49 INFO - 'MAIL': '/var/mail/cltbld', 12:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:49 INFO - 'MOZ_NO_REMOTE': '1', 12:48:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:49 INFO - 'NO_EM_RESTART': '1', 12:48:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:48:49 INFO - 'PWD': '/builds/slave/test-pgo', 12:48:49 INFO - 'SHELL': '/bin/bash', 12:48:49 INFO - 'SHLVL': '1', 12:48:49 INFO - 'TERM': 'linux', 12:48:49 INFO - 'TMOUT': '86400', 12:48:49 INFO - 'USER': 'cltbld', 12:48:49 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448052444.742510-424514314', 12:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:49 INFO - '_': '/tools/buildbot/bin/python'} 12:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:49 INFO - Downloading/unpacking psutil>=0.7.1 12:48:49 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 12:48:49 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 12:48:49 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 12:48:49 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 12:48:49 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 12:48:49 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 12:48:51 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 12:48:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:48:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 12:48:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:48:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:48:51 INFO - Installing collected packages: psutil 12:48:51 INFO - Running setup.py install for psutil 12:48:51 INFO - building 'psutil._psutil_linux' extension 12:48:51 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 12:48:51 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 12:48:51 INFO - building 'psutil._psutil_posix' extension 12:48:51 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 12:48:51 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 12:48:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:48:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:48:52 INFO - Successfully installed psutil 12:48:52 INFO - Cleaning up... 12:48:52 INFO - Return code: 0 12:48:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 12:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:52 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 0x7f936e822c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14017c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1445d70>, '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 0x1446b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1446fb0>, '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': '6587686cb2da90a5f91b3170000001be-1448052444.742510-424514314', '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 12:48:52 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 12:48:52 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 12:48:52 INFO - Using env: {'DISPLAY': ':0', 12:48:52 INFO - 'HOME': '/home/cltbld', 12:48:52 INFO - 'LANG': 'en_US.UTF-8', 12:48:52 INFO - 'LANGUAGE': 'en_US:en', 12:48:52 INFO - 'LOGNAME': 'cltbld', 12:48:52 INFO - 'MAIL': '/var/mail/cltbld', 12:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:52 INFO - 'MOZ_NO_REMOTE': '1', 12:48:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:52 INFO - 'NO_EM_RESTART': '1', 12:48:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:48:52 INFO - 'PWD': '/builds/slave/test-pgo', 12:48:52 INFO - 'SHELL': '/bin/bash', 12:48:52 INFO - 'SHLVL': '1', 12:48:52 INFO - 'TERM': 'linux', 12:48:52 INFO - 'TMOUT': '86400', 12:48:52 INFO - 'USER': 'cltbld', 12:48:52 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448052444.742510-424514314', 12:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:52 INFO - '_': '/tools/buildbot/bin/python'} 12:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:48:52 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 12:48:52 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 12:48:52 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 12:48:52 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 12:48:52 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 12:48:52 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 12:48:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:48:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:48:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:48:53 INFO - Installing collected packages: mozsystemmonitor 12:48:53 INFO - Running setup.py install for mozsystemmonitor 12:48:54 INFO - Successfully installed mozsystemmonitor 12:48:54 INFO - Cleaning up... 12:48:54 INFO - Return code: 0 12:48:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 12:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:54 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 0x7f936e822c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14017c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1445d70>, '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 0x1446b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1446fb0>, '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': '6587686cb2da90a5f91b3170000001be-1448052444.742510-424514314', '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 12:48:54 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 12:48:54 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 12:48:54 INFO - Using env: {'DISPLAY': ':0', 12:48:54 INFO - 'HOME': '/home/cltbld', 12:48:54 INFO - 'LANG': 'en_US.UTF-8', 12:48:54 INFO - 'LANGUAGE': 'en_US:en', 12:48:54 INFO - 'LOGNAME': 'cltbld', 12:48:54 INFO - 'MAIL': '/var/mail/cltbld', 12:48:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:54 INFO - 'MOZ_NO_REMOTE': '1', 12:48:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:54 INFO - 'NO_EM_RESTART': '1', 12:48:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:48:54 INFO - 'PWD': '/builds/slave/test-pgo', 12:48:54 INFO - 'SHELL': '/bin/bash', 12:48:54 INFO - 'SHLVL': '1', 12:48:54 INFO - 'TERM': 'linux', 12:48:54 INFO - 'TMOUT': '86400', 12:48:54 INFO - 'USER': 'cltbld', 12:48:54 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448052444.742510-424514314', 12:48:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:54 INFO - '_': '/tools/buildbot/bin/python'} 12:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:54 INFO - Downloading/unpacking blobuploader==1.2.4 12:48:54 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 12:48:54 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 12:48:54 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 12:48:54 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 12:48:54 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 12:48:54 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 12:48:55 INFO - Downloading blobuploader-1.2.4.tar.gz 12:48:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:48:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:48:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:48:56 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 12:48:56 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 12:48:56 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 12:48:56 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 12:48:56 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 12:48:56 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 12:48:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:48:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 12:48:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:48:56 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 12:48:56 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 12:48:56 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 12:48:56 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 12:48:56 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 12:48:56 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 12:48:56 INFO - Downloading docopt-0.6.1.tar.gz 12:48:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:48:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 12:48:56 INFO - Installing collected packages: blobuploader, requests, docopt 12:48:56 INFO - Running setup.py install for blobuploader 12:48:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:48:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 12:48:56 INFO - Running setup.py install for requests 12:48:57 INFO - Running setup.py install for docopt 12:48:57 INFO - Successfully installed blobuploader requests docopt 12:48:57 INFO - Cleaning up... 12:48:57 INFO - Return code: 0 12:48:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:57 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 0x7f936e822c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14017c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1445d70>, '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 0x1446b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1446fb0>, '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': '6587686cb2da90a5f91b3170000001be-1448052444.742510-424514314', '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 12:48:57 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 12:48:57 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 12:48:57 INFO - Using env: {'DISPLAY': ':0', 12:48:57 INFO - 'HOME': '/home/cltbld', 12:48:57 INFO - 'LANG': 'en_US.UTF-8', 12:48:57 INFO - 'LANGUAGE': 'en_US:en', 12:48:57 INFO - 'LOGNAME': 'cltbld', 12:48:57 INFO - 'MAIL': '/var/mail/cltbld', 12:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:57 INFO - 'MOZ_NO_REMOTE': '1', 12:48:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:57 INFO - 'NO_EM_RESTART': '1', 12:48:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:48:57 INFO - 'PWD': '/builds/slave/test-pgo', 12:48:57 INFO - 'SHELL': '/bin/bash', 12:48:57 INFO - 'SHLVL': '1', 12:48:57 INFO - 'TERM': 'linux', 12:48:57 INFO - 'TMOUT': '86400', 12:48:57 INFO - 'USER': 'cltbld', 12:48:57 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448052444.742510-424514314', 12:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:57 INFO - '_': '/tools/buildbot/bin/python'} 12:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:48:57 INFO - Running setup.py (path:/tmp/pip-QxsTZG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:48:57 INFO - Running setup.py (path:/tmp/pip-teIAxx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:48:57 INFO - Running setup.py (path:/tmp/pip-sXWHPI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:48:57 INFO - Running setup.py (path:/tmp/pip-ygfsHF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:48:57 INFO - Running setup.py (path:/tmp/pip-VX1ah0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:48:57 INFO - Running setup.py (path:/tmp/pip-5rE3u7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:48:57 INFO - Running setup.py (path:/tmp/pip-2dKXt_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:48:57 INFO - Running setup.py (path:/tmp/pip-5kFCQP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:48:58 INFO - Running setup.py (path:/tmp/pip-LbpTjz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:48:58 INFO - Running setup.py (path:/tmp/pip-OoKr1E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:48:58 INFO - Running setup.py (path:/tmp/pip-GztxkS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:48:58 INFO - Running setup.py (path:/tmp/pip-_LMV7U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:48:58 INFO - Running setup.py (path:/tmp/pip-JTzVKj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:48:58 INFO - Running setup.py (path:/tmp/pip-xF4J3C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:48:58 INFO - Running setup.py (path:/tmp/pip-ij7rSH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:48:58 INFO - Running setup.py (path:/tmp/pip-rPMlUJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:48:58 INFO - Running setup.py (path:/tmp/pip-PQNRFS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:48:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:48:58 INFO - Running setup.py install for manifestparser 12:48:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 12:48:58 INFO - Running setup.py install for mozcrash 12:48:58 INFO - Running setup.py install for mozdebug 12:48:58 INFO - Running setup.py install for mozdevice 12:48:59 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 12:48:59 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 12:48:59 INFO - Running setup.py install for mozfile 12:48:59 INFO - Running setup.py install for mozhttpd 12:48:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 12:48:59 INFO - Running setup.py install for mozinfo 12:48:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 12:48:59 INFO - Running setup.py install for mozInstall 12:48:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 12:48:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 12:48:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 12:48:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 12:48:59 INFO - Running setup.py install for mozleak 12:48:59 INFO - Running setup.py install for mozlog 12:48:59 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 12:48:59 INFO - Running setup.py install for moznetwork 12:48:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 12:48:59 INFO - Running setup.py install for mozprocess 12:48:59 INFO - Running setup.py install for mozprofile 12:49:00 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 12:49:00 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 12:49:00 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 12:49:00 INFO - Running setup.py install for mozrunner 12:49:00 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 12:49:00 INFO - Running setup.py install for mozscreenshot 12:49:00 INFO - Running setup.py install for moztest 12:49:00 INFO - Running setup.py install for mozversion 12:49:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 12:49:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:49:00 INFO - Cleaning up... 12:49:00 INFO - Return code: 0 12:49:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:49:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:00 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 0x7f936e822c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14017c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1445d70>, '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 0x1446b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1446fb0>, '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': '6587686cb2da90a5f91b3170000001be-1448052444.742510-424514314', '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 12:49:00 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 12:49:00 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 12:49:00 INFO - Using env: {'DISPLAY': ':0', 12:49:00 INFO - 'HOME': '/home/cltbld', 12:49:00 INFO - 'LANG': 'en_US.UTF-8', 12:49:00 INFO - 'LANGUAGE': 'en_US:en', 12:49:00 INFO - 'LOGNAME': 'cltbld', 12:49:00 INFO - 'MAIL': '/var/mail/cltbld', 12:49:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:00 INFO - 'MOZ_NO_REMOTE': '1', 12:49:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:00 INFO - 'NO_EM_RESTART': '1', 12:49:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:49:00 INFO - 'PWD': '/builds/slave/test-pgo', 12:49:00 INFO - 'SHELL': '/bin/bash', 12:49:00 INFO - 'SHLVL': '1', 12:49:00 INFO - 'TERM': 'linux', 12:49:00 INFO - 'TMOUT': '86400', 12:49:00 INFO - 'USER': 'cltbld', 12:49:00 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448052444.742510-424514314', 12:49:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:00 INFO - '_': '/tools/buildbot/bin/python'} 12:49:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:49:00 INFO - Running setup.py (path:/tmp/pip-drS6ta-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:49:00 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)) 12:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:49:00 INFO - Running setup.py (path:/tmp/pip-fM9rU6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:49:00 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)) 12:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:49:00 INFO - Running setup.py (path:/tmp/pip-WGysrk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:49:00 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)) 12:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:49:00 INFO - Running setup.py (path:/tmp/pip-5wwaBU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:49:00 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)) 12:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:49:00 INFO - Running setup.py (path:/tmp/pip-lBJSA9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:49:01 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)) 12:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:49:01 INFO - Running setup.py (path:/tmp/pip-PUZlxd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:49:01 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)) 12:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:49:01 INFO - Running setup.py (path:/tmp/pip-HGrsxa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:49:01 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)) 12:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:49:01 INFO - Running setup.py (path:/tmp/pip-b2fLtO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:49:01 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)) 12:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:49:01 INFO - Running setup.py (path:/tmp/pip-mtpL0y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:49:01 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)) 12:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:49:01 INFO - Running setup.py (path:/tmp/pip-FCHOsL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:49:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:49:01 INFO - Running setup.py (path:/tmp/pip-AGyZ26-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:49:01 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)) 12:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:49:01 INFO - Running setup.py (path:/tmp/pip-Ji3Bp1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:49:01 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)) 12:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:49:01 INFO - Running setup.py (path:/tmp/pip-sF0_Yh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:49:01 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)) 12:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:49:01 INFO - Running setup.py (path:/tmp/pip-MeDag_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:49:01 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)) 12:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:49:01 INFO - Running setup.py (path:/tmp/pip-pVyw1c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:49:01 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)) 12:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:49:01 INFO - Running setup.py (path:/tmp/pip-_hAEzj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:49:01 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)) 12:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:49:01 INFO - Running setup.py (path:/tmp/pip-CIFGpV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:49:01 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)) 12:49:01 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)) 12:49:01 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)) 12:49:01 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)) 12:49:01 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)) 12:49:01 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)) 12:49:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:49:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:49:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:49:03 INFO - Downloading blessings-1.5.1.tar.gz 12:49:03 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 12:49:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 12:49:03 INFO - Installing collected packages: blessings 12:49:03 INFO - Running setup.py install for blessings 12:49:03 INFO - Successfully installed blessings 12:49:03 INFO - Cleaning up... 12:49:03 INFO - Return code: 0 12:49:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 12:49:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:49:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:49:04 INFO - Reading from file tmpfile_stdout 12:49:04 INFO - Current package versions: 12:49:04 INFO - argparse == 1.2.1 12:49:04 INFO - blessings == 1.5.1 12:49:04 INFO - blobuploader == 1.2.4 12:49:04 INFO - docopt == 0.6.1 12:49:04 INFO - manifestparser == 1.1 12:49:04 INFO - mozInstall == 1.12 12:49:04 INFO - mozcrash == 0.16 12:49:04 INFO - mozdebug == 0.1 12:49:04 INFO - mozdevice == 0.47 12:49:04 INFO - mozfile == 1.2 12:49:04 INFO - mozhttpd == 0.7 12:49:04 INFO - mozinfo == 0.9 12:49:04 INFO - mozleak == 0.1 12:49:04 INFO - mozlog == 3.0 12:49:04 INFO - moznetwork == 0.27 12:49:04 INFO - mozprocess == 0.22 12:49:04 INFO - mozprofile == 0.27 12:49:04 INFO - mozrunner == 6.11 12:49:04 INFO - mozscreenshot == 0.1 12:49:04 INFO - mozsystemmonitor == 0.0 12:49:04 INFO - moztest == 0.7 12:49:04 INFO - mozversion == 1.4 12:49:04 INFO - psutil == 3.1.1 12:49:04 INFO - requests == 1.2.3 12:49:04 INFO - wsgiref == 0.1.2 12:49:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:49:04 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')]} 12:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:04 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')]} 12:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:04 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 0x7f936e822c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14017c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1445d70>, '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 0x1446b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1446fb0>, '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': '6587686cb2da90a5f91b3170000001be-1448052444.742510-424514314', '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 12:49:04 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 12:49:04 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 12:49:04 INFO - Using env: {'DISPLAY': ':0', 12:49:04 INFO - 'HOME': '/home/cltbld', 12:49:04 INFO - 'LANG': 'en_US.UTF-8', 12:49:04 INFO - 'LANGUAGE': 'en_US:en', 12:49:04 INFO - 'LOGNAME': 'cltbld', 12:49:04 INFO - 'MAIL': '/var/mail/cltbld', 12:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:04 INFO - 'MOZ_NO_REMOTE': '1', 12:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:04 INFO - 'NO_EM_RESTART': '1', 12:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:49:04 INFO - 'PWD': '/builds/slave/test-pgo', 12:49:04 INFO - 'SHELL': '/bin/bash', 12:49:04 INFO - 'SHLVL': '1', 12:49:04 INFO - 'TERM': 'linux', 12:49:04 INFO - 'TMOUT': '86400', 12:49:04 INFO - 'USER': 'cltbld', 12:49:04 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448052444.742510-424514314', 12:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:04 INFO - '_': '/tools/buildbot/bin/python'} 12:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:04 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)) 12:49:04 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)) 12:49:04 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)) 12:49:04 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)) 12:49:04 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)) 12:49:04 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)) 12:49:04 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)) 12:49:04 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)) 12:49:04 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)) 12:49:04 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)) 12:49:04 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)) 12:49:04 INFO - Cleaning up... 12:49:04 INFO - Return code: 0 12:49:04 INFO - Running post-action listener: _resource_record_post_action 12:49:04 INFO - Running post-action listener: _start_resource_monitoring 12:49:04 INFO - Starting resource monitoring. 12:49:04 INFO - ##### 12:49:04 INFO - ##### Running install step. 12:49:04 INFO - ##### 12:49:04 INFO - Running pre-action listener: _resource_record_pre_action 12:49:04 INFO - Running main action method: install 12:49:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:49:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:49:04 INFO - Reading from file tmpfile_stdout 12:49:04 INFO - Detecting whether we're running mozinstall >=1.0... 12:49:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 12:49:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 12:49:04 INFO - Reading from file tmpfile_stdout 12:49:04 INFO - Output received: 12:49:04 INFO - Usage: mozinstall [options] installer 12:49:04 INFO - Options: 12:49:04 INFO - -h, --help show this help message and exit 12:49:04 INFO - -d DEST, --destination=DEST 12:49:04 INFO - Directory to install application into. [default: 12:49:04 INFO - "/builds/slave/test-pgo"] 12:49:04 INFO - --app=APP Application being installed. [default: firefox] 12:49:04 INFO - mkdir: /builds/slave/test-pgo/build/application 12:49:04 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'] 12:49:04 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 12:49:19 INFO - Reading from file tmpfile_stdout 12:49:19 INFO - Output received: 12:49:19 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 12:49:19 INFO - Running post-action listener: _resource_record_post_action 12:49:19 INFO - ##### 12:49:19 INFO - ##### Running run-tests step. 12:49:19 INFO - ##### 12:49:19 INFO - Running pre-action listener: _resource_record_pre_action 12:49:19 INFO - Running main action method: run_tests 12:49:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 12:49:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 12:49:19 INFO - Python 2.7.3 12:49:19 INFO - Return code: 0 12:49:19 INFO - grabbing minidump binary from tooltool 12:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:49:19 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 0x1445d70>, '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 0x1446b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1446fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 12:49:19 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 12:49:19 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 12:49:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:49:19 INFO - Return code: 0 12:49:19 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 12:49:19 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 12:49:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 12:49:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 12:49:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 12:49:19 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/WCICnORvQFCwGij-EsGXSA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 12:49:19 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/WCICnORvQFCwGij-EsGXSA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost 12:49:19 INFO - Using env: {'DISPLAY': ':0', 12:49:19 INFO - 'HOME': '/home/cltbld', 12:49:19 INFO - 'LANG': 'en_US.UTF-8', 12:49:19 INFO - 'LANGUAGE': 'en_US:en', 12:49:19 INFO - 'LOGNAME': 'cltbld', 12:49:19 INFO - 'MAIL': '/var/mail/cltbld', 12:49:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:49:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 12:49:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:19 INFO - 'MOZ_NO_REMOTE': '1', 12:49:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:49:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:19 INFO - 'NO_EM_RESTART': '1', 12:49:19 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:49:19 INFO - 'PWD': '/builds/slave/test-pgo', 12:49:19 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 12:49:19 INFO - 'SHELL': '/bin/bash', 12:49:19 INFO - 'SHLVL': '1', 12:49:19 INFO - 'TERM': 'linux', 12:49:19 INFO - 'TMOUT': '86400', 12:49:19 INFO - 'USER': 'cltbld', 12:49:19 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448052444.742510-424514314', 12:49:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:19 INFO - '_': '/tools/buildbot/bin/python'} 12:49:19 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/WCICnORvQFCwGij-EsGXSA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost'] with output_timeout 3600 12:49:19 INFO - mozversion INFO | application_buildid: 20151120113004 12:49:19 INFO - mozversion INFO | application_changeset: 106bfad77bf44d39fc334b336b037a70c2130d52 12:49:19 INFO - mozversion INFO | application_display_name: Nightly 12:49:19 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:49:19 INFO - mozversion INFO | application_name: Firefox 12:49:19 INFO - mozversion INFO | application_remotingname: firefox 12:49:19 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 12:49:19 INFO - mozversion INFO | application_vendor: Mozilla 12:49:19 INFO - mozversion INFO | application_version: 45.0a1 12:49:19 INFO - mozversion INFO | platform_buildid: 20151120113004 12:49:19 INFO - mozversion INFO | platform_changeset: 106bfad77bf44d39fc334b336b037a70c2130d52 12:49:19 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 12:49:19 INFO - mozversion INFO | platform_version: 45.0a1 12:49:19 INFO - 2015-11-20 12:49:19,334 DEBUG : using testdate: 1448052559 12:49:19 INFO - 2015-11-20 12:49:19,334 DEBUG : actual date: 1448052559 12:49:19 INFO - 2015-11-20 12:49:19,343 INFO : starting webserver on 'localhost:36028' 12:49:19 INFO - 2015-11-20 12:49:19,345 INFO : Starting test suite talos-linux64-ix-017 12:49:19 INFO - 2015-11-20 12:49:19,345 INFO : Starting test dromaeo_css 12:49:19 INFO - 2015-11-20 12:49:19,345 DEBUG : operating with platform_type : linux_ 12:49:19 INFO - 2015-11-20 12:49:19,345 INFO : Initialising browser for dromaeo_css test... 12:49:19 INFO - 2015-11-20 12:49:19,361 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWz2y0o/profile http://localhost:36028/getInfo.html 12:49:22 INFO - 2015-11-20 12:49:22,852 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:49:22 INFO - 2015-11-20 12:49:22,853 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:49:22 INFO - 2015-11-20 12:49:22,853 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:49:22 INFO - 2015-11-20 12:49:22,853 DEBUG : BROWSER_OUTPUT: __metrics 12:49:22 INFO - 2015-11-20 12:49:22,969 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:49:24 INFO - 2015-11-20 12:49:24,081 INFO : Browser initialized. 12:49:24 INFO - 2015-11-20 12:49:24,081 INFO : Running cycle 1/1 for dromaeo_css test... 12:49:24 INFO - 2015-11-20 12:49:24,082 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWz2y0o/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:49:35 INFO - 2015-11-20 12:49:35,801 DEBUG : BROWSER_OUTPUT: RSS: Main: 142196736 12:49:35 INFO - 2015-11-20 12:49:35,801 DEBUG : BROWSER_OUTPUT: 12:50:27 INFO - 2015-11-20 12:50:27,397 DEBUG : BROWSER_OUTPUT: 1448052627395 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] 12:52:35 INFO - 2015-11-20 12:52:35,025 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36028/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36028/tests/dromaeo/cssquery-ext.html) 12:52:36 INFO - 2015-11-20 12:52:36,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 235438080 12:52:36 INFO - 2015-11-20 12:52:36,111 DEBUG : BROWSER_OUTPUT: 12:55:38 INFO - 2015-11-20 12:55:38,483 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36028/tests/dromaeo/cssquery-ext.html (next: http://localhost:36028/tests/dromaeo/cssquery-jquery.html) 12:55:39 INFO - 2015-11-20 12:55:39,057 DEBUG : BROWSER_OUTPUT: RSS: Main: 227819520 12:55:39 INFO - 2015-11-20 12:55:39,057 DEBUG : BROWSER_OUTPUT: 12:58:40 INFO - 2015-11-20 12:58:40,980 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36028/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36028/tests/dromaeo/cssquery-mootools.html) 12:58:41 INFO - 2015-11-20 12:58:41,547 DEBUG : BROWSER_OUTPUT: RSS: Main: 222306304 12:58:41 INFO - 2015-11-20 12:58:41,547 DEBUG : BROWSER_OUTPUT: 13:01:43 INFO - 2015-11-20 13:01:43,460 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36028/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36028/tests/dromaeo/cssquery-prototype.html) 13:01:44 INFO - 2015-11-20 13:01:44,025 DEBUG : BROWSER_OUTPUT: RSS: Main: 206659584 13:01:44 INFO - 2015-11-20 13:01:44,026 DEBUG : BROWSER_OUTPUT: 13:04:46 INFO - 2015-11-20 13:04:46,595 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36028/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36028/tests/dromaeo/cssquery-yui.html) 13:04:47 INFO - 2015-11-20 13:04:47,162 DEBUG : BROWSER_OUTPUT: RSS: Main: 207433728 13:04:47 INFO - 2015-11-20 13:04:47,162 DEBUG : BROWSER_OUTPUT: 13:07:49 INFO - 2015-11-20 13:07:49,850 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36028/tests/dromaeo/cssquery-yui.html (next: http://localhost:36028/tests/dromaeo/cssquery-dojo.html) 13:07:50 INFO - 2015-11-20 13:07:50,108 DEBUG : BROWSER_OUTPUT: RSS: Main: 260079616 13:07:50 INFO - 2015-11-20 13:07:50,108 DEBUG : BROWSER_OUTPUT: 13:07:50 INFO - 2015-11-20 13:07:50,109 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:07:50 INFO - 2015-11-20 13:07:50,109 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:07:50 INFO - 2015-11-20 13:07:50,109 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:07:50 INFO - 2015-11-20 13:07:50,109 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:07:50 INFO - 2015-11-20 13:07:50,109 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3147.669494703056;3221.2752130770596;3260.152360386299;3272.8690852365908;3280.458724310488;5231.267622532839;5356.3036805215315;5356.3572371315395;5425.538829199518;5457.099578569531;5350.759215835287;5366.436524164956;5384.40771515133;5418;5430.91853622195;4838.733869637169;4909.5581397674205;4952.529509696573;4956.876078098049;4973.776180071905;165.86486326623157;4985.52637499437;5041.798328066873;5058.7976480940715;5103.974480127613;4975.0547395994645;4986.551210391064;4996.375453068366;4999.775010124553;5009.799608015694;4985.975070124626;4988.02733466974;4993;5006.249062640633;5030.144875371196;4753.667243292971;4986.4265609455015;4993.00139972007;4994.976029913859;5000.649954503187;5140.665856719339;5145.382554093495;5178.766955487012;5213;5226.8693282667855;5790.942090579082;5791.65250084992;5794.21778059965;5797.420257974211;5800.158976948361;5582.637128586629;5759.3376761672525;5798.217240672498;5805.4194580542035;5815.767369305223;5393.19102134679;5441.374241962146;5447.1829225616075;5447.863803404907;5459.590530710213;5906.114082887515;5922.289325280908;5923.052311630118;5925.555583331267;5928.140419639129;5599.440055994368;5694.747155625756;5715.914261286084;5726.226959360516;5754.424557544212;5664.773409063591;5707.258056452634;5711.171880077449;5717.685527295956;5760.855978600569;5733.856653583611;5739.16782066598;5741.827745167651;5747.798827041033;5748.913766293509;5637.154426836008;5738.397468265855;5744.684042377626;5758.452946970031;5763.596548241667;4441.600255976978;4481.619062379734;4484.170428470743;4522.389477420572;4527.185106680829;4003.099302656937;4019.4975628046495;4063.91872162561;4071.6742660587083;4095.672346212296;5289.550388216968;5371.704556249366;5406.675599464044;5544.500994910478;5552.555795536347;5679.233303503974;5692.260006199168;5693.459121383462;5699.344575373802;5726.856828579319;5438.483344082385;5447.073997420448;5448.182772584065;5449.972750136224;5467.152591348347;4894.461609222983;4991.650584459053;5036.169032109661;5067.037262920034;5104.719240441737;6048.395160483917;6080.665563394055;6084.300305464928;6085.726142323606;6092.543059270483;5811.070228763378;5840.678762668094;5856.180134781049;5859.033259512304;5875.089361149029;5879.529637629065;5920.822375328747;5973.372795856372;6020.127081573235;6031.974564323988;5662.150677398423;5684;5692.715364231854;5694.003549378925;5708.971455142698;5606.635568688022;5654.773809047592;5700.059490184073;5724.713764311851;5725.742341594555;5517.200005999028;5610.102383618601;5615.606907516598;5617.045102332695;5666.065099258576;5675.177099320658;5687;5688.232088667977;5695.45893140151;5700.25896633435;5416.75624596902;5597.580181486486;5608.383077861514;5609.21470994053;5609.579281553818;5572.804951826666;5634.74643641029;5648.4633959773755;5650.491455769001;5691.14632805066;5594.888102237851;5598.32820061579;5603.495685388335;5608.691521966168;5612.635178713371 13:07:50 INFO - 2015-11-20 13:07:50,109 DEBUG : BROWSER_OUTPUT: |1;ext.html;580.3413126101874;588.8675048114175;590.7046476761619;603.2670305578721;611.8776244751051;31541.211469713267;32142;39388;40499.79750101245;40526.79736601313;41862.7906860466;42213.733587992334;42415.151696966044;42424.36363454551;42464;7581.583012934287;8600.698975535857;8850.690225842096;8858.335624828163;8860.734177974671;7648.502847314907;10476.633317833877;10723.678289651283;10728.78542429151;10729.678109656723;10369.740756481073;10437.791244175112;10477.895221047767;10480.633177838778;10493.108085812715;7641.426892983049;7809.453338266324;10327.07056364927;10432.426216558086;10440.269181157322;10444.373337599693;10741.83887241692;10742;10742.248042637018;10743.83884241737;39645.801770991246;39779.60220397817;40089.191526804905;40111.59888401108;40116.197676046606;3427.3316703242876;3931.567527571965;3945.270125026879;3946.1515774108702;3960.920781584352;30561;30905.227369315722;30948;30964.8451757742;31941.52087718686;3869.6517313441645;3878.864239751595;3913.5108111486065;3913.6869050475893;3981.3629819229072;273061;273662;274685;275072.999999998;275159;51381.743091285054;53300.73349633227;58690;59407.702961484916;60538;53914.46085539173;54334.45665543373;54418.183727244126;54563.635909101795;54677;15795.447159349367;15976.121313327878;15989;15997.680046399008;16002.839971600135;11944.880551194377;12028.09789265791;12030.518779248732;12037.337946413032;12169.695757605954;19555.41333759961;20079;20098.598028039356;20118;20143.899280503505;7567.772966811004;7752.186020467882;7775.688972441039;7806.024246969129;7807.531548107132;896.305363343401;909.377076702461;1007.8538611901233;1012.2863381316155;1075.930064545802;27608.861955690092;27805.582916256273;27858.303542411602;28069.157925262276;28240.71759282422;1034.6275340877278;1039.101177481473;1072.0726571515584;1108.5953626926275;1129.728865072393;14590.489332873298;14632.561023169323;15098.773518397233;15385.461508847136;15461.690766184613;244879;249100;249143;249222;249412;51191.23213151806;51646.22530662043;51708.741456292475;51731.448056558365;51793.44619661341;1311.8622544632867;1325.8342707161605;1336.2583766009764;1339.4039652354804;1339.9732005359838;27750.167494975183;28093.719062809112;28679.283017923884;28741;28819.423611527232;41779.7911010443;45527.08945821131;45884.770576146904;45925.54074459212;45993.77003114963;245631;419689;426876;427678;427982;29921.102366929026;30506;30530.542041869834;30547;30567.54148687727;41782.79108604437;42249.577504225796;42495;43472.130557388045;43490.56509434992;34394.528711267376;35265.1183720409;35722;36353.81823090973;36929.26141477209;32213.51679724853;32216.516752249205;32397.19007024843;32443.18892027718;32564.674353257113;31532.684673153894;32160.678393215767;32332.838335809112;32432.35135297328;32630.34739305248;31572;31723.20691982719;32262.19344516406;32311.838440807645;32366.514502282957;24666.753332466447;25871.353216169748;25914;26016.609750853375;26282.60576091322 13:07:50 INFO - 2015-11-20 13:07:50,109 DEBUG : BROWSER_OUTPUT: |2;jquery.html;353.2352456930743;354.0720775378064;356.68967997841884;357.6441440766438;360.1248965015014;14290.214038227894;14328.355224014918;16537.17314134293;17632.294708211673;18929.33747318844;16007.35970561179;16430.7535386969;16559.83440165598;16586.917065414655;16976.15119244039;4817.78319975602;5470.070088085015;5478.808241711541;5479.698616576086;5480.314960629921;3941.4679018332445;4067.2475592015426;5407.729613519328;5447.237386765836;5751.7986870459545;5771.3074431068335;5812.505936995361;5813.796517121901;5821.67980761058;5848.327442344121;5759.078547432412;5830.970845145768;5973.910391344133;5978.282606087298;5989.670568118751;5267.26258323835;5283.815066472655;5285.550728188108;5294;5301.840944771663;18553.072346382625;19935.50161245966;20090.799092009038;20326.79673203264;20855.687164692543;2088.5300807318386;2156.6225910465764;2175.8150557202657;2252.9436764080865;2332.2303639798824;12989.740205195938;13099.541516046987;13188.274644894527;13393.531226407127;13629.931850340785;1745.4327343613377;1810.8682073703935;1868.3647559829587;1874.372085351409;1900.277894400119;58053.12920306199;58462;59816;60449;60549.78900422011;9621.08599683029;9905.752356191153;9981.151602113756;10066.647667331608;10081.59673613062;12948.417321220379;13017.544385946447;13021.153625014344;13030;13034.478620855249;7845.293923546908;7852.607369631495;7855.253750893656;7915.812628105715;7918.722844700408;7799.142094369615;7812.414068944739;7827.060752709711;7833.2166783322355;7870.252326029018;5909.970450147808;5960.672163031075;6008.969955150284;6023.759049638053;6044.667543285162;1666.1252842257911;1720.9053502057507;1745.4589077386051;1750.6061136244243;1766.434740882905;851.8892543969245;883.6553744039829;923.8013827027087;958.7842735384482;993.6323560282742;14455.204963727096;16108.355665773237;16664.58338541522;17115.400960966308;17462.301507939796;840.2269911681268;859.3597769661517;881.9823603528022;896.789254525186;943.9716808495756;8887.289016878634;9324.300677449219;9350.205232555309;9433.198178154933;9496.90503094974;514201;515731;520993;523321;524285;74420.25579744134;80610;80920.59539702264;81827;82043;1163.4241050679968;1174.1311429542077;1186.7151883547886;1186.8101103823346;1189.2507720136432;14518.20149891766;15498.147601882005;15517.068975861484;15525.84474155244;15787.68424631478;34082.31835363329;34566.13584660403;34637.30725385529;34736.82631586826;34811.30377392488;43089.78455107704;43298.13403731971;45277;46183.30725039195;46570.534294656616;8827.293816494537;9493.715188544355;9502.287328450531;9506.429614223169;9509.381890177116;11275.436228188393;11303.095752339957;16300.184990750178;17967.011814349815;18205.635887282446;14392.136471811726;14515.201663908165;14667.413303467742;14776.261186940825;15000;14289.499867504588;14303.713925721218;14600.488982885548;14892.62768430798;15127.848721512644;11950.701232469259;12428.75712428786;13241.933790330986;13844.653883652989;13946.79079813824;8690.782730431536;9255.76860578491;9257.537123143682;9258.074192580689;9607.471589062668;9591.664291749756;9709.805803884024;13711.862881371058;13768.518101866386;14529.636759080684 13:07:50 INFO - 2015-11-20 13:07:50,109 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1416.4829837109455;1452.5279284232624;1526.7557190849466;1587.8174009988854;1748.6327871147066;7056;7254.600996945166;7637.656305466254;7771.961140194306;7783.066032076144;7626.847463050735;7698.576578288192;7735.497192682472;7751.6124193790365;7754.030746156731;1895.9572235270614;1914.8276655101038;2247.9887600562015;2273.318004598622;2273.57938781326;2268.9886550567226;2334.6731457595865;2336.6261398176293;2336.649502574619;2337.719473663154;2177.2379667116543;2200.3508964855405;2234.530748542808;2239.54089411671;2240.1599400224914;1986.5927484865567;2033.268023511542;2149.3981685128188;2241.2491815241915;2247.5617254635354;2207.55848830233;2232;2233.4304752288226;2235.854669446481;2237.518933429304;7845.725399610987;7890.723824666109;7939.245771651684;7943.324817390529;7949.403794715419;4607.700499467557;4693.225617773063;4693.624510039189;4720.57514823664;4721.811127554894;3145.5438961350706;3201.3917355702574;3206.198450387403;3208.98395508021;3261.7390608751243;1129.7458071933831;1963.1950900130878;1967.6950072738748;1981.2471260920902;1989.184434381911;10758.731031724192;10853.403062831541;10857.294275872122;10858.67423977282;10874;4080.0615858352153;4132.049628585382;4172.687048471377;4212.494500659879;4213.705040647125;8641.740747777576;8644.265237454762;8645.524496152771;8655.09121542229;8662.82674346522;4672.182368085571;4672.649551283667;4693.601043911238;4701.247800351927;4701.341812146302;4293.527711951683;4318.568143185719;4336.219480493478;4342.891427714269;4350.282203436397;3382.5095361172494;3394.168428734976;3399.4730816722954;3422.264213194125;3422.3839708852147;1081.1080858291941;1105.8120119579692;1114.4650567727535;1118.770652016351;1122.9213955023233;1027.0705011964185;1040.089921318846;1040.245821779204;1158.507634255438;1297.9935100324437;6940.722371105099;7057.400120989773;7250.3112204340505;7438.070241219848;7442;545.5008667069666;552.2875490617059;556.807901274068;557.0780358506678;559;5557.166425036277;5560.77756889728;5623.184638227516;5651.378348381675;5656.8868622627315;9147.131022552847;9788.657396991071;9820.558074886647;9857.605695772088;9872.35829671069;9579.13787759091;9582.137607615348;9733.610655573839;9739.805203895883;9753.951230243803;7248.601326926964;7425.1832298447125;7451.068616423056;7512.812179695551;7522.699092036367;6860.382565569123;6884.8967265490055;6928.411085057826;6946.583205007716;6967.442604591722;8445;8491.83016339682;8598.226159645661;8624.137586241326;8646.351523635878;8646.783830404038;8793.428427152214;8794.824103518022;8929.821403572023;8931;6529.967350163219;6557.639329836905;6574.605523668595;6615.073889655356;6649.401553859982;7566.432517561315;7595.5822429764685;7632.923670763222;7641.388688904985;7647.044119485065;7108.289171082851;7134.250903655042;7135.179454362607;7163.283671632795;7202.855942881218;6846.178458585002;6886.827829304308;6909.516333856783;7014.0531028310525;7026.754063607749;6211.440970312694;6495.577787443801;6968.059311993019;7013.333733295329;7015.088038554955;6140.894638965029;6424.229092508742;6517.348265173445;6518.837029074311;6524;6442.420182183439;6461.547691661539;6505.41451269388;6516.218053833571;6516.967415162894 13:07:50 INFO - 2015-11-20 13:07:50,110 DEBUG : BROWSER_OUTPUT: |4;prototype.html;295.33549513594414;298.32876028934896;301.8505839609394;314.75291895861744;319.8256949962271;6060.181875446819;6062.8787424251595;6081.756729730811;6089.725962331695;6093.573449858512;5931.555133364994;5936.673482958447;5939.1388248703915;5943.643381397108;5947.791827286046;4488.798004089824;4500.639948804096;4505.301678239878;4509.120721459317;4510.684252102355;4378.890527736816;4455.688101832873;4514.390557274775;4514.480834704002;4521.32180172975;4369.082492676542;4377.47470303564;4387.319965405367;4430.246858034142;4468.240399132139;4458.086092351093;4458.308962110878;4461.330800379953;4465.151621191963;4475.351074094238;3785.0726571989762;3850.287696776077;3863.092173339263;3865.5747867734526;3867.0719027433493;5564.944350556483;5705.258316418881;5716.742746576414;5732.942670573282;5755.568332375046;5227.3988491323225;5240.580753539708;5247.580193584504;5248.947510524884;5254.553362964152;5979.043353063489;6142.26292844857;6306.87386252277;6319.842003949892;6330.17707698001;4274.850380236677;4325.134973005412;4333.58830911063;4333.653307735373;4349.412829268072;6555.6066636001515;6556.147700798913;6556.147700798913;6559.573627714183;6562.343765623399;4429.68992170545;4430.180416622935;4430.8449204277695;4435;4437.933430998538;4387.978060109679;4483.14820184164;4498.392716983165;4501.167284052461;4505.639548836085;5191.195364718399;5229.08491014071;5232.424433312332;5243.842684719464;5248.527632513016;6384.904226436607;6391.872162556723;6392.872142557123;6394.744210231539;6394.784990851724;1575.9763603545955;1606.3654856331916;1606.5421354913794;1607.5900645335364;1608.1637548474728;1027.4708525109575;1036.1762398892897;1042.2495803021811;1044.1490185498947;1092.055372103141;6065.059915713072;6149.41580549847;6158.476529494954;6159.291681456601;6160.568760186834;6533.901991470132;6538.869222615521;6545.247296560861;6547.639879806561;6584.604923704593;5983.850403739942;6125.295591007002;6125.754969801158;6133.478654314344;6140.600860944024;3521.1197200699826;3526.7883926964464;3549.9112522186633;3555.2356243407276;3556.76881002734;6756.459483241329;6761.72953081881;6764.898526522106;6767.796966091025;6767.864642707217;6489.740410383626;6630.502712296597;6631.171103612049;6632.336766323426;6643.036759669821;6760.594364338155;6767.492438067165;6770.221424536143;6777.49168812341;6777.525573209828;6394;6509.902351464637;6516.706748196438;6524.445422139172;6562.5406221564035;6590.275069742229;6594.307597702172;6605.207375114825;6607;6619.6028238303925;6905.689243984133;6920.204176519765;6922.550034247758;6926.411255043377;6930.549514281757;4348.326009468537;4441.20058389493;4455.376247325442;4455.5098939117315;4456.866294011184;6568.047633093271;6607.636579988147;6611.504137189634;6621.735130594722;6626.56927299724;6428.935710643021;6430.099786029866;6435.774747883802;6439.06633538125;6439.581427207217;6304.747810087545;6383.1382763326355;6402.391772781578;6469.741210351722;6482.675866206765;6317.241930968313;6327.715252813727;6358.046293056079;6363.96818015907;6367.968160159169;6512.73949042033;6518.543701940818;6522.412982831568;6523.793098276834;6525.673716314261;6204.410580994799;6340.365963403623;6344.080108384166;6344.619322840645;6362.872742545216 13:07:50 INFO - 2015-11-20 13:07:50,112 DEBUG : BROWSER_OUTPUT: |5;yui.html;721.3219573600815;785.9960700196498;822.5475988206485;854.5769843927261;860.0797147052655;13390.866091339083;13930.791038134435;13960.790588141173;13961.37173827179;13966.371513281902;12581.308028058453;12613.243205407682;12636.873631263685;12672.493100275979;12691.3654317284;669.8693754717832;674.871774362872;794.0709370037071;800.7397595781365;817.8159914019328;803.4536515169682;814.9755507334789;822.0998007182126;822.1080128061031;822.1655020154518;850.2900078434515;852.9360297977645;858.0732808566733;861.0098386855135;862.211076864668;702.5433468245656;709.0180100560734;837.4891316297054;850.0606829453488;854.0733304364771;629.4177885455981;629.8960671489199;630.0549176235646;630.612173513286;630.9022101574263;13325.666858328523;13424.865751342459;13445.932770336183;13468.326583670778;13478.730425391535;11229.3262404256;11604.767904641943;11749.29504229749;11886.167968242227;11935.820962685566;10134.13859821916;10163.237757168168;10275.948620256926;10363.274570780048;10392.220583456272;3560.181158333598;3561.3411518869093;3617.692496137805;3621.7826930384263;3700.40793473043;45312.54687453116;45634.771826140655;45636;45778.31332530015;45927.081458370645;9690.660826871026;9906.900930990598;10066.59733610662;10385.428801415843;10395.064444200058;17348.913255433643;17515.737263940795;17525.123743812757;17539;17578.296868125388;7228.783136505913;7477.887831682529;7511.774646760606;7611.581363024976;7696.769096927102;4202.936955945664;4203.47456567929;4240.893977650521;4247.915041699149;4283.678724095706;3009.8946536871103;3016.834074125944;3030.5151175811766;3032.5451182322386;3035.8330291833718;509.3353174107751;525.414163208028;532.0954377558166;532.478171392038;535.0769921884795;569.6952130610103;608.9725962331705;624.316373570939;650.4601181019742;671.8891382921763;8283.62723677436;8352.457090289112;8354.540500272422;8386.958065209636;8554.18735220153;542.5252903709254;586.3784388548153;651.5919802535849;683.4122654517112;715.1704023332909;3824.674902633252;3825.885223443301;3845.538535375773;3945.881623551298;3977.622125898035;58849;59209.70395147997;59284.70357648184;59287;59391.70304148538;53244.73377633087;53253.46746532562;53987;54367.45632543703;54776.17835732467;48844;48957;49386.506134938194;49488.50511494839;49623.751881240365;8197.877031844408;8277.420580559303;8612.181842725182;8782.780430489289;8954.373193876367;37014.25971480609;37938.62061379351;37946.810265948494;39110;40375.19249614933;48751.5124848747;48794.51205488042;48945.14767932564;49034.50965490299;49423;11511.481983310938;11565.884341156481;11666.76666466649;11886.108541859223;12022.63932082039;11263.887361126612;11710.765784684429;11822.290662560274;12546;12690.048246381373;10690.83963740529;10783.892161078289;10930.070943969851;11206.49570769301;11207.719807004563;10160.644377446753;10307.484625768831;10883.074938630305;10903.563857445613;10941.781164376509;7180.676869540987;9523.333366664545;10934.343939363345;11417.31496110236;11706.648800535997;9614.51927403613;9626.229901607994;9798.902010979798;10216.693499195037;10406.843897341394;9729.173020293072;9751;9853.408795472295;9905.603775848886;9918 13:07:50 INFO - 2015-11-20 13:07:50,112 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:07:50 INFO - 2015-11-20 13:07:50,112 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:07:50 INFO - 2015-11-20 13:07:50,112 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,854 13:07:50 INFO - 2015-11-20 13:07:50,112 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:07:50 INFO - 2015-11-20 13:07:50,112 DEBUG : BROWSER_OUTPUT: __startTimestamp1448053670101__endTimestamp 13:07:50 INFO - 2015-11-20 13:07:50,112 DEBUG : BROWSER_OUTPUT: 13:07:50 INFO - 2015-11-20 13:07:50,112 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:07:50 INFO - 2015-11-20 13:07:50,112 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:07:50 INFO - 2015-11-20 13:07:50,112 DEBUG : BROWSER_OUTPUT: 13:07:50 INFO - 2015-11-20 13:07:50,113 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5345.71 Median:5599.44 stddev:704.60 (12.6%) stddev-sans-first:685.34 13:07:50 INFO - 2015-11-20 13:07:50,114 DEBUG : BROWSER_OUTPUT: Values: 3147.7 3221.3 3260.2 3272.9 3280.5 5231.3 5356.3 5356.4 5425.5 5457.1 5350.8 5366.4 5384.4 5418.0 5430.9 4838.7 4909.6 4952.5 4956.9 4973.8 165.9 4985.5 5041.8 5058.8 5104.0 4975.1 4986.6 4996.4 4999.8 5009.8 4986.0 4988.0 4993.0 5006.2 5030.1 4753.7 4986.4 4993.0 4995.0 5000.6 5140.7 5145.4 5178.8 5213.0 5226.9 5790.9 5791.7 5794.2 5797.4 5800.2 5582.6 5759.3 5798.2 5805.4 5815.8 5393.2 5441.4 5447.2 5447.9 5459.6 5906.1 5922.3 5923.1 5925.6 5928.1 5599.4 5694.7 5715.9 5726.2 5754.4 5664.8 5707.3 5711.2 5717.7 5760.9 5733.9 5739.2 5741.8 5747.8 5748.9 5637.2 5738.4 5744.7 5758.5 5763.6 4441.6 4481.6 4484.2 4522.4 4527.2 4003.1 4019.5 4063.9 4071.7 4095.7 5289.6 5371.7 5406.7 5544.5 5552.6 5679.2 5692.3 5693.5 5699.3 5726.9 5438.5 5447.1 5448.2 5450.0 5467.2 4894.5 4991.7 5036.2 5067.0 5104.7 6048.4 6080.7 6084.3 6085.7 6092.5 5811.1 5840.7 5856.2 5859.0 5875.1 5879.5 5920.8 5973.4 6020.1 6032.0 5662.2 5684.0 5692.7 5694.0 5709.0 5606.6 5654.8 5700.1 5724.7 5725.7 5517.2 5610.1 5615.6 5617.0 5666.1 5675.2 5687.0 5688.2 5695.5 5700.3 5416.8 5597.6 5608.4 5609.2 5609.6 5572.8 5634.7 5648.5 5650.5 5691.1 5594.9 5598.3 5603.5 5608.7 5612.6 13:07:50 INFO - 2015-11-20 13:07:50,114 DEBUG : BROWSER_OUTPUT: 13:07:50 INFO - 2015-11-20 13:07:50,114 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46921.75 Median:32151.34 stddev:82256.39 (255.8%) stddev-sans-first:82413.55 13:07:50 INFO - 2015-11-20 13:07:50,114 DEBUG : BROWSER_OUTPUT: Values: 580.3 588.9 590.7 603.3 611.9 31541.2 32142.0 39388.0 40499.8 40526.8 41862.8 42213.7 42415.2 42424.4 42464.0 7581.6 8600.7 8850.7 8858.3 8860.7 7648.5 10476.6 10723.7 10728.8 10729.7 10369.7 10437.8 10477.9 10480.6 10493.1 7641.4 7809.5 10327.1 10432.4 10440.3 10444.4 10741.8 10742.0 10742.2 10743.8 39645.8 39779.6 40089.2 40111.6 40116.2 3427.3 3931.6 3945.3 3946.2 3960.9 30561.0 30905.2 30948.0 30964.8 31941.5 3869.7 3878.9 3913.5 3913.7 3981.4 273061.0 273662.0 274685.0 275073.0 275159.0 51381.7 53300.7 58690.0 59407.7 60538.0 53914.5 54334.5 54418.2 54563.6 54677.0 15795.4 15976.1 15989.0 15997.7 16002.8 11944.9 12028.1 12030.5 12037.3 12169.7 19555.4 20079.0 20098.6 20118.0 20143.9 7567.8 7752.2 7775.7 7806.0 7807.5 896.3 909.4 1007.9 1012.3 1075.9 27608.9 27805.6 27858.3 28069.2 28240.7 1034.6 1039.1 1072.1 1108.6 1129.7 14590.5 14632.6 15098.8 15385.5 15461.7 244879.0 249100.0 249143.0 249222.0 249412.0 51191.2 51646.2 51708.7 51731.4 51793.4 1311.9 1325.8 1336.3 1339.4 1340.0 27750.2 28093.7 28679.3 28741.0 28819.4 41779.8 45527.1 45884.8 45925.5 45993.8 245631.0 419689.0 426876.0 427678.0 427982.0 29921.1 30506.0 30530.5 30547.0 30567.5 41782.8 42249.6 42495.0 43472.1 43490.6 34394.5 35265.1 35722.0 36353.8 36929.3 32213.5 32216.5 32397.2 32443.2 32564.7 31532.7 32160.7 32332.8 32432.4 32630.3 31572.0 31723.2 32262.2 32311.8 32366.5 24666.8 25871.4 25914.0 26016.6 26282.6 13:07:50 INFO - 2015-11-20 13:07:50,114 DEBUG : BROWSER_OUTPUT: 13:07:50 INFO - 2015-11-20 13:07:50,114 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28193.34 Median:4004.36 stddev:84910.78 (2120.5%) stddev-sans-first:85123.24 13:07:50 INFO - 2015-11-20 13:07:50,114 DEBUG : BROWSER_OUTPUT: Values: 353.2 354.1 356.7 357.6 360.1 14290.2 14328.4 16537.2 17632.3 18929.3 16007.4 16430.8 16559.8 16586.9 16976.2 4817.8 5470.1 5478.8 5479.7 5480.3 3941.5 4067.2 5407.7 5447.2 5751.8 5771.3 5812.5 5813.8 5821.7 5848.3 5759.1 5831.0 5973.9 5978.3 5989.7 5267.3 5283.8 5285.6 5294.0 5301.8 18553.1 19935.5 20090.8 20326.8 20855.7 2088.5 2156.6 2175.8 2252.9 2332.2 12989.7 13099.5 13188.3 13393.5 13629.9 1745.4 1810.9 1868.4 1874.4 1900.3 58053.1 58462.0 59816.0 60449.0 60549.8 9621.1 9905.8 9981.2 10066.6 10081.6 12948.4 13017.5 13021.2 13030.0 13034.5 7845.3 7852.6 7855.3 7915.8 7918.7 7799.1 7812.4 7827.1 7833.2 7870.3 5910.0 5960.7 6009.0 6023.8 6044.7 1666.1 1720.9 1745.5 1750.6 1766.4 851.9 883.7 923.8 958.8 993.6 14455.2 16108.4 16664.6 17115.4 17462.3 840.2 859.4 882.0 896.8 944.0 8887.3 9324.3 9350.2 9433.2 9496.9 514201.0 515731.0 520993.0 523321.0 524285.0 74420.3 80610.0 80920.6 81827.0 82043.0 1163.4 1174.1 1186.7 1186.8 1189.3 14518.2 15498.1 15517.1 15525.8 15787.7 34082.3 34566.1 34637.3 34736.8 34811.3 43089.8 43298.1 45277.0 46183.3 46570.5 8827.3 9493.7 9502.3 9506.4 9509.4 11275.4 11303.1 16300.2 17967.0 18205.6 14392.1 14515.2 14667.4 14776.3 15000.0 14289.5 14303.7 14600.5 14892.6 15127.8 11950.7 12428.8 13241.9 13844.7 13946.8 8690.8 9255.8 9257.5 9258.1 9607.5 9591.7 9709.8 13711.9 13768.5 14529.6 13:07:50 INFO - 2015-11-20 13:07:50,114 DEBUG : BROWSER_OUTPUT: 13:07:50 INFO - 2015-11-20 13:07:50,115 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5447.96 Median:6176.17 stddev:2857.82 (46.3%) stddev-sans-first:2849.77 13:07:50 INFO - 2015-11-20 13:07:50,116 DEBUG : BROWSER_OUTPUT: Values: 1416.5 1452.5 1526.8 1587.8 1748.6 7056.0 7254.6 7637.7 7772.0 7783.1 7626.8 7698.6 7735.5 7751.6 7754.0 1896.0 1914.8 2248.0 2273.3 2273.6 2269.0 2334.7 2336.6 2336.6 2337.7 2177.2 2200.4 2234.5 2239.5 2240.2 1986.6 2033.3 2149.4 2241.2 2247.6 2207.6 2232.0 2233.4 2235.9 2237.5 7845.7 7890.7 7939.2 7943.3 7949.4 4607.7 4693.2 4693.6 4720.6 4721.8 3145.5 3201.4 3206.2 3209.0 3261.7 1129.7 1963.2 1967.7 1981.2 1989.2 10758.7 10853.4 10857.3 10858.7 10874.0 4080.1 4132.0 4172.7 4212.5 4213.7 8641.7 8644.3 8645.5 8655.1 8662.8 4672.2 4672.6 4693.6 4701.2 4701.3 4293.5 4318.6 4336.2 4342.9 4350.3 3382.5 3394.2 3399.5 3422.3 3422.4 1081.1 1105.8 1114.5 1118.8 1122.9 1027.1 1040.1 1040.2 1158.5 1298.0 6940.7 7057.4 7250.3 7438.1 7442.0 545.5 552.3 556.8 557.1 559.0 5557.2 5560.8 5623.2 5651.4 5656.9 9147.1 9788.7 9820.6 9857.6 9872.4 9579.1 9582.1 9733.6 9739.8 9754.0 7248.6 7425.2 7451.1 7512.8 7522.7 6860.4 6884.9 6928.4 6946.6 6967.4 8445.0 8491.8 8598.2 8624.1 8646.4 8646.8 8793.4 8794.8 8929.8 8931.0 6530.0 6557.6 6574.6 6615.1 6649.4 7566.4 7595.6 7632.9 7641.4 7647.0 7108.3 7134.3 7135.2 7163.3 7202.9 6846.2 6886.8 6909.5 7014.1 7026.8 6211.4 6495.6 6968.1 7013.3 7015.1 6140.9 6424.2 6517.3 6518.8 6524.0 6442.4 6461.5 6505.4 6516.2 6517.0 13:07:50 INFO - 2015-11-20 13:07:50,116 DEBUG : BROWSER_OUTPUT: 13:07:50 INFO - 2015-11-20 13:07:50,116 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5300.01 Median:6085.74 stddev:1631.04 (26.8%) stddev-sans-first:1591.78 13:07:50 INFO - 2015-11-20 13:07:50,116 DEBUG : BROWSER_OUTPUT: Values: 295.3 298.3 301.9 314.8 319.8 6060.2 6062.9 6081.8 6089.7 6093.6 5931.6 5936.7 5939.1 5943.6 5947.8 4488.8 4500.6 4505.3 4509.1 4510.7 4378.9 4455.7 4514.4 4514.5 4521.3 4369.1 4377.5 4387.3 4430.2 4468.2 4458.1 4458.3 4461.3 4465.2 4475.4 3785.1 3850.3 3863.1 3865.6 3867.1 5564.9 5705.3 5716.7 5732.9 5755.6 5227.4 5240.6 5247.6 5248.9 5254.6 5979.0 6142.3 6306.9 6319.8 6330.2 4274.9 4325.1 4333.6 4333.7 4349.4 6555.6 6556.1 6556.1 6559.6 6562.3 4429.7 4430.2 4430.8 4435.0 4437.9 4388.0 4483.1 4498.4 4501.2 4505.6 5191.2 5229.1 5232.4 5243.8 5248.5 6384.9 6391.9 6392.9 6394.7 6394.8 1576.0 1606.4 1606.5 1607.6 1608.2 1027.5 1036.2 1042.2 1044.1 1092.1 6065.1 6149.4 6158.5 6159.3 6160.6 6533.9 6538.9 6545.2 6547.6 6584.6 5983.9 6125.3 6125.8 6133.5 6140.6 3521.1 3526.8 3549.9 3555.2 3556.8 6756.5 6761.7 6764.9 6767.8 6767.9 6489.7 6630.5 6631.2 6632.3 6643.0 6760.6 6767.5 6770.2 6777.5 6777.5 6394.0 6509.9 6516.7 6524.4 6562.5 6590.3 6594.3 6605.2 6607.0 6619.6 6905.7 6920.2 6922.6 6926.4 6930.5 4348.3 4441.2 4455.4 4455.5 4456.9 6568.0 6607.6 6611.5 6621.7 6626.6 6428.9 6430.1 6435.8 6439.1 6439.6 6304.7 6383.1 6402.4 6469.7 6482.7 6317.2 6327.7 6358.0 6364.0 6368.0 6512.7 6518.5 6522.4 6523.8 6525.7 6204.4 6340.4 6344.1 6344.6 6362.9 13:07:50 INFO - 2015-11-20 13:07:50,116 DEBUG : BROWSER_OUTPUT: 13:07:50 INFO - 2015-11-20 13:07:50,116 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14052.08 Median:48894.57 stddev:16677.15 (34.1%) stddev-sans-first:16693.89 13:07:50 INFO - 2015-11-20 13:07:50,116 DEBUG : BROWSER_OUTPUT: Values: 721.3 786.0 822.5 854.6 860.1 13390.9 13930.8 13960.8 13961.4 13966.4 12581.3 12613.2 12636.9 12672.5 12691.4 669.9 674.9 794.1 800.7 817.8 803.5 815.0 822.1 822.1 822.2 850.3 852.9 858.1 861.0 862.2 702.5 709.0 837.5 850.1 854.1 629.4 629.9 630.1 630.6 630.9 13325.7 13424.9 13445.9 13468.3 13478.7 11229.3 11604.8 11749.3 11886.2 11935.8 10134.1 10163.2 10275.9 10363.3 10392.2 3560.2 3561.3 3617.7 3621.8 3700.4 45312.5 45634.8 45636.0 45778.3 45927.1 9690.7 9906.9 10066.6 10385.4 10395.1 17348.9 17515.7 17525.1 17539.0 17578.3 7228.8 7477.9 7511.8 7611.6 7696.8 4202.9 4203.5 4240.9 4247.9 4283.7 3009.9 3016.8 3030.5 3032.5 3035.8 509.3 525.4 532.1 532.5 535.1 569.7 609.0 624.3 650.5 671.9 8283.6 8352.5 8354.5 8387.0 8554.2 542.5 586.4 651.6 683.4 715.2 3824.7 3825.9 3845.5 3945.9 3977.6 58849.0 59209.7 59284.7 59287.0 59391.7 53244.7 53253.5 53987.0 54367.5 54776.2 48844.0 48957.0 49386.5 49488.5 49623.8 8197.9 8277.4 8612.2 8782.8 8954.4 37014.3 37938.6 37946.8 39110.0 40375.2 48751.5 48794.5 48945.1 49034.5 49423.0 11511.5 11565.9 11666.8 11886.1 12022.6 11263.9 11710.8 11822.3 12546.0 12690.0 10690.8 10783.9 10930.1 11206.5 11207.7 10160.6 10307.5 10883.1 10903.6 10941.8 7180.7 9523.3 10934.3 11417.3 11706.6 9614.5 9626.2 9798.9 10216.7 10406.8 9729.2 9751.0 9853.4 9905.6 9918.0 13:07:50 INFO - 2015-11-20 13:07:50,116 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:07:50 INFO - 2015-11-20 13:07:50,116 DEBUG : BROWSER_OUTPUT: 13:07:50 INFO - 2015-11-20 13:07:50,785 INFO : Browser exited with error code: 0 13:07:50 INFO - 2015-11-20 13:07:50,803 INFO : Completed test dromaeo_css (00:18:31) 13:07:50 INFO - 2015-11-20 13:07:50,803 INFO : Starting test kraken 13:07:50 INFO - 2015-11-20 13:07:50,803 DEBUG : operating with platform_type : linux_ 13:07:50 INFO - 2015-11-20 13:07:50,803 INFO : Initialising browser for kraken test... 13:07:50 INFO - 2015-11-20 13:07:50,809 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCawZUs/profile http://localhost:36028/getInfo.html 13:07:54 INFO - 2015-11-20 13:07:54,414 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:07:54 INFO - 2015-11-20 13:07:54,414 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:07:54 INFO - 2015-11-20 13:07:54,414 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:07:54 INFO - 2015-11-20 13:07:54,414 DEBUG : BROWSER_OUTPUT: __metrics 13:07:54 INFO - 2015-11-20 13:07:54,556 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:07:55 INFO - 2015-11-20 13:07:55,680 INFO : Browser initialized. 13:07:55 INFO - 2015-11-20 13:07:55,681 INFO : Running cycle 1/1 for kraken test... 13:07:55 INFO - 2015-11-20 13:07:55,681 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCawZUs/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:08:07 INFO - 2015-11-20 13:08:07,466 DEBUG : BROWSER_OUTPUT: RSS: Main: 142307328 13:08:07 INFO - 2015-11-20 13:08:07,467 DEBUG : BROWSER_OUTPUT: 13:08:09 INFO - 2015-11-20 13:08:09,905 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36028/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36028/tests/kraken/driver.html?testName=audio-beat-detection) 13:08:10 INFO - 2015-11-20 13:08:10,486 DEBUG : BROWSER_OUTPUT: RSS: Main: 179826688 13:08:10 INFO - 2015-11-20 13:08:10,486 DEBUG : BROWSER_OUTPUT: 13:08:13 INFO - 2015-11-20 13:08:13,095 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36028/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36028/tests/kraken/driver.html?testName=audio-dft) 13:08:13 INFO - 2015-11-20 13:08:13,669 DEBUG : BROWSER_OUTPUT: RSS: Main: 168148992 13:08:13 INFO - 2015-11-20 13:08:13,669 DEBUG : BROWSER_OUTPUT: 13:08:16 INFO - 2015-11-20 13:08:16,507 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36028/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36028/tests/kraken/driver.html?testName=audio-fft) 13:08:17 INFO - 2015-11-20 13:08:17,068 DEBUG : BROWSER_OUTPUT: RSS: Main: 151560192 13:08:17 INFO - 2015-11-20 13:08:17,068 DEBUG : BROWSER_OUTPUT: 13:08:19 INFO - 2015-11-20 13:08:19,040 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36028/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36028/tests/kraken/driver.html?testName=audio-oscillator) 13:08:19 INFO - 2015-11-20 13:08:19,606 DEBUG : BROWSER_OUTPUT: RSS: Main: 155074560 13:08:19 INFO - 2015-11-20 13:08:19,607 DEBUG : BROWSER_OUTPUT: 13:08:21 INFO - 2015-11-20 13:08:21,761 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36028/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36028/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:08:22 INFO - 2015-11-20 13:08:22,314 DEBUG : BROWSER_OUTPUT: RSS: Main: 154906624 13:08:22 INFO - 2015-11-20 13:08:22,314 DEBUG : BROWSER_OUTPUT: 13:08:25 INFO - 2015-11-20 13:08:25,212 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36028/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36028/tests/kraken/driver.html?testName=imaging-darkroom) 13:08:25 INFO - 2015-11-20 13:08:25,794 DEBUG : BROWSER_OUTPUT: RSS: Main: 156041216 13:08:25 INFO - 2015-11-20 13:08:25,794 DEBUG : BROWSER_OUTPUT: 13:08:29 INFO - 2015-11-20 13:08:29,167 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36028/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36028/tests/kraken/driver.html?testName=imaging-desaturate) 13:08:29 INFO - 2015-11-20 13:08:29,737 DEBUG : BROWSER_OUTPUT: RSS: Main: 156192768 13:08:29 INFO - 2015-11-20 13:08:29,737 DEBUG : BROWSER_OUTPUT: 13:08:32 INFO - 2015-11-20 13:08:32,482 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36028/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36028/tests/kraken/driver.html?testName=json-parse-financial) 13:08:33 INFO - 2015-11-20 13:08:33,048 DEBUG : BROWSER_OUTPUT: RSS: Main: 157020160 13:08:33 INFO - 2015-11-20 13:08:33,048 DEBUG : BROWSER_OUTPUT: 13:08:34 INFO - 2015-11-20 13:08:34,638 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36028/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36028/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:08:35 INFO - 2015-11-20 13:08:35,191 DEBUG : BROWSER_OUTPUT: RSS: Main: 162639872 13:08:35 INFO - 2015-11-20 13:08:35,191 DEBUG : BROWSER_OUTPUT: 13:08:37 INFO - 2015-11-20 13:08:37,002 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36028/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36028/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:08:37 INFO - 2015-11-20 13:08:37,595 DEBUG : BROWSER_OUTPUT: RSS: Main: 162152448 13:08:37 INFO - 2015-11-20 13:08:37,595 DEBUG : BROWSER_OUTPUT: 13:08:39 INFO - 2015-11-20 13:08:39,628 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36028/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36028/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:08:40 INFO - 2015-11-20 13:08:40,201 DEBUG : BROWSER_OUTPUT: RSS: Main: 167428096 13:08:40 INFO - 2015-11-20 13:08:40,202 DEBUG : BROWSER_OUTPUT: 13:08:42 INFO - 2015-11-20 13:08:42,617 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36028/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36028/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:08:43 INFO - 2015-11-20 13:08:43,204 DEBUG : BROWSER_OUTPUT: RSS: Main: 176852992 13:08:43 INFO - 2015-11-20 13:08:43,205 DEBUG : BROWSER_OUTPUT: 13:08:45 INFO - 2015-11-20 13:08:45,787 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36028/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36028/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:08:46 INFO - 2015-11-20 13:08:46,355 DEBUG : BROWSER_OUTPUT: RSS: Main: 174686208 13:08:46 INFO - 2015-11-20 13:08:46,355 DEBUG : BROWSER_OUTPUT: 13:08:48 INFO - 2015-11-20 13:08:48,036 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36028/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36028/tests/kraken/driver.html?testName=ai-astar) 13:08:48 INFO - 2015-11-20 13:08:48,295 DEBUG : BROWSER_OUTPUT: RSS: Main: 234287104 13:08:48 INFO - 2015-11-20 13:08:48,295 DEBUG : BROWSER_OUTPUT: 13:08:48 INFO - 2015-11-20 13:08:48,295 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:08:48 INFO - 2015-11-20 13:08:48,295 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:08:48 INFO - 2015-11-20 13:08:48,296 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:08:48 INFO - 2015-11-20 13:08:48,296 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:08:48 INFO - 2015-11-20 13:08:48,296 DEBUG : BROWSER_OUTPUT: |0;ai-astar;107;109;103;109;111;109;99;109;108;106 13:08:48 INFO - 2015-11-20 13:08:48,296 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;125;151;165;126;150;153;125;162;126 13:08:48 INFO - 2015-11-20 13:08:48,296 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;160;160;162;160;160;163;162;160 13:08:48 INFO - 2015-11-20 13:08:48,296 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;80;93;71;71;71;102;90;71 13:08:48 INFO - 2015-11-20 13:08:48,297 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;91;132;89;90;91;147;90;91;135 13:08:48 INFO - 2015-11-20 13:08:48,297 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;109;109;109;110;109;109;110 13:08:48 INFO - 2015-11-20 13:08:48,297 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;147;145;145;145;145;145;146;145 13:08:48 INFO - 2015-11-20 13:08:48,297 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;97;96;96;95;96 13:08:48 INFO - 2015-11-20 13:08:48,297 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;59;60;60;59;60;59;70;58;58 13:08:48 INFO - 2015-11-20 13:08:48,298 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;67;68;68;70;67;83;68;68 13:08:48 INFO - 2015-11-20 13:08:48,298 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;86;85;86;84;84;85;85;87;85 13:08:48 INFO - 2015-11-20 13:08:48,298 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;122;125;121;136;120;122;121;120;125 13:08:48 INFO - 2015-11-20 13:08:48,298 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;155;155;142;169;153;143;149;151;141 13:08:48 INFO - 2015-11-20 13:08:48,298 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;68;69;68;68;68;66;70;67;70 13:08:48 INFO - 2015-11-20 13:08:48,298 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:08:48 INFO - 2015-11-20 13:08:48,299 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:08:48 INFO - 2015-11-20 13:08:48,299 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,911 13:08:48 INFO - 2015-11-20 13:08:48,299 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:08:48 INFO - 2015-11-20 13:08:48,299 DEBUG : BROWSER_OUTPUT: __startTimestamp1448053728287__endTimestamp 13:08:48 INFO - 2015-11-20 13:08:48,299 DEBUG : BROWSER_OUTPUT: 13:08:48 INFO - 2015-11-20 13:08:48,299 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:08:48 INFO - 2015-11-20 13:08:48,299 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:08:48 INFO - 2015-11-20 13:08:48,300 DEBUG : BROWSER_OUTPUT: 13:08:48 INFO - 2015-11-20 13:08:48,300 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.00 Median:109.00 stddev:3.56 (3.3%) stddev-sans-first:3.77 13:08:48 INFO - 2015-11-20 13:08:48,300 DEBUG : BROWSER_OUTPUT: Values: 107.0 109.0 103.0 109.0 111.0 109.0 99.0 109.0 108.0 106.0 13:08:48 INFO - 2015-11-20 13:08:48,300 DEBUG : BROWSER_OUTPUT: 13:08:48 INFO - 2015-11-20 13:08:48,300 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.30 Median:150.50 stddev:16.10 (10.7%) stddev-sans-first:16.89 13:08:48 INFO - 2015-11-20 13:08:48,300 DEBUG : BROWSER_OUTPUT: Values: 150.0 125.0 151.0 165.0 126.0 150.0 153.0 125.0 162.0 126.0 13:08:48 INFO - 2015-11-20 13:08:48,301 DEBUG : BROWSER_OUTPUT: 13:08:48 INFO - 2015-11-20 13:08:48,301 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.15 (0.7%) stddev-sans-first:1.17 13:08:48 INFO - 2015-11-20 13:08:48,301 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 160.0 160.0 162.0 160.0 160.0 163.0 162.0 160.0 13:08:48 INFO - 2015-11-20 13:08:48,301 DEBUG : BROWSER_OUTPUT: 13:08:48 INFO - 2015-11-20 13:08:48,301 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.20 Median:71.50 stddev:11.62 (16.3%) stddev-sans-first:11.94 13:08:48 INFO - 2015-11-20 13:08:48,301 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 80.0 93.0 71.0 71.0 71.0 102.0 90.0 71.0 13:08:48 INFO - 2015-11-20 13:08:48,301 DEBUG : BROWSER_OUTPUT: 13:08:48 INFO - 2015-11-20 13:08:48,301 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.70 Median:90.50 stddev:23.29 (25.7%) stddev-sans-first:24.17 13:08:48 INFO - 2015-11-20 13:08:48,301 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 132.0 89.0 90.0 91.0 147.0 90.0 91.0 135.0 13:08:48 INFO - 2015-11-20 13:08:48,302 DEBUG : BROWSER_OUTPUT: 13:08:48 INFO - 2015-11-20 13:08:48,302 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 13:08:48 INFO - 2015-11-20 13:08:48,302 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 110.0 13:08:48 INFO - 2015-11-20 13:08:48,302 DEBUG : BROWSER_OUTPUT: 13:08:48 INFO - 2015-11-20 13:08:48,302 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 13:08:48 INFO - 2015-11-20 13:08:48,302 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 147.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 13:08:48 INFO - 2015-11-20 13:08:48,302 DEBUG : BROWSER_OUTPUT: 13:08:48 INFO - 2015-11-20 13:08:48,302 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 13:08:48 INFO - 2015-11-20 13:08:48,302 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 95.0 96.0 13:08:48 INFO - 2015-11-20 13:08:48,302 DEBUG : BROWSER_OUTPUT: 13:08:48 INFO - 2015-11-20 13:08:48,302 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.20 Median:59.50 stddev:3.52 (5.9%) stddev-sans-first:3.71 13:08:48 INFO - 2015-11-20 13:08:48,303 DEBUG : BROWSER_OUTPUT: Values: 59.0 59.0 60.0 60.0 59.0 60.0 59.0 70.0 58.0 58.0 13:08:48 INFO - 2015-11-20 13:08:48,303 DEBUG : BROWSER_OUTPUT: 13:08:48 INFO - 2015-11-20 13:08:48,303 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:68.00 stddev:4.86 (7.1%) stddev-sans-first:5.07 13:08:48 INFO - 2015-11-20 13:08:48,303 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 67.0 68.0 68.0 70.0 67.0 83.0 68.0 68.0 13:08:48 INFO - 2015-11-20 13:08:48,303 DEBUG : BROWSER_OUTPUT: 13:08:48 INFO - 2015-11-20 13:08:48,303 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.00 stddev:0.92 (1.1%) stddev-sans-first:0.97 13:08:48 INFO - 2015-11-20 13:08:48,303 DEBUG : BROWSER_OUTPUT: Values: 85.0 86.0 85.0 86.0 84.0 84.0 85.0 85.0 87.0 85.0 13:08:48 INFO - 2015-11-20 13:08:48,303 DEBUG : BROWSER_OUTPUT: 13:08:48 INFO - 2015-11-20 13:08:48,303 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:122.00 stddev:4.87 (4.0%) stddev-sans-first:5.03 13:08:48 INFO - 2015-11-20 13:08:48,303 DEBUG : BROWSER_OUTPUT: Values: 120.0 122.0 125.0 121.0 136.0 120.0 122.0 121.0 120.0 125.0 13:08:48 INFO - 2015-11-20 13:08:48,303 DEBUG : BROWSER_OUTPUT: 13:08:48 INFO - 2015-11-20 13:08:48,305 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.30 Median:152.00 stddev:8.43 (5.5%) stddev-sans-first:8.72 13:08:48 INFO - 2015-11-20 13:08:48,305 DEBUG : BROWSER_OUTPUT: Values: 145.0 155.0 155.0 142.0 169.0 153.0 143.0 149.0 151.0 141.0 13:08:48 INFO - 2015-11-20 13:08:48,305 DEBUG : BROWSER_OUTPUT: 13:08:48 INFO - 2015-11-20 13:08:48,305 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:1.23 (1.8%) stddev-sans-first:1.30 13:08:48 INFO - 2015-11-20 13:08:48,305 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 69.0 68.0 68.0 68.0 66.0 70.0 67.0 70.0 13:08:48 INFO - 2015-11-20 13:08:48,305 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:08:48 INFO - 2015-11-20 13:08:48,305 DEBUG : BROWSER_OUTPUT: 13:08:49 INFO - 2015-11-20 13:08:49,133 INFO : Browser exited with error code: 0 13:08:49 INFO - 2015-11-20 13:08:49,191 INFO : Completed test kraken (00:00:58) 13:08:49 INFO - 2015-11-20 13:08:49,191 INFO : Starting test v8_7 13:08:49 INFO - 2015-11-20 13:08:49,191 DEBUG : operating with platform_type : linux_ 13:08:49 INFO - 2015-11-20 13:08:49,191 INFO : Initialising browser for v8_7 test... 13:08:49 INFO - 2015-11-20 13:08:49,197 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoJ5BtV/profile http://localhost:36028/getInfo.html 13:08:52 INFO - 2015-11-20 13:08:52,790 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:08:52 INFO - 2015-11-20 13:08:52,790 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:08:52 INFO - 2015-11-20 13:08:52,790 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:08:52 INFO - 2015-11-20 13:08:52,790 DEBUG : BROWSER_OUTPUT: __metrics 13:08:52 INFO - 2015-11-20 13:08:52,907 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:08:53 INFO - 2015-11-20 13:08:53,967 INFO : Browser initialized. 13:08:53 INFO - 2015-11-20 13:08:53,968 INFO : Running cycle 1/1 for v8_7 test... 13:08:53 INFO - 2015-11-20 13:08:53,968 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoJ5BtV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:09:05 INFO - 2015-11-20 13:09:05,686 DEBUG : BROWSER_OUTPUT: RSS: Main: 142131200 13:09:05 INFO - 2015-11-20 13:09:05,687 DEBUG : BROWSER_OUTPUT: 13:09:27 INFO - 2015-11-20 13:09:27,078 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36028/tests/v8_7/run.html (next: http://localhost:36028/tests/v8_7/run.html) 13:09:27 INFO - 2015-11-20 13:09:27,336 DEBUG : BROWSER_OUTPUT: RSS: Main: 528080896 13:09:27 INFO - 2015-11-20 13:09:27,336 DEBUG : BROWSER_OUTPUT: 13:09:27 INFO - 2015-11-20 13:09:27,336 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:09:27 INFO - 2015-11-20 13:09:27,336 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:09:27 INFO - 2015-11-20 13:09:27,337 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:09:27 INFO - 2015-11-20 13:09:27,337 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:09:27 INFO - 2015-11-20 13:09:27,337 DEBUG : BROWSER_OUTPUT: |0;Richards;163.1321370309951 13:09:27 INFO - 2015-11-20 13:09:27,337 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.98642095053347 13:09:27 INFO - 2015-11-20 13:09:27,337 DEBUG : BROWSER_OUTPUT: |2;Encrypt;287.60425654299684 13:09:27 INFO - 2015-11-20 13:09:27,337 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5020 13:09:27 INFO - 2015-11-20 13:09:27,337 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1107.4197120708748 13:09:27 INFO - 2015-11-20 13:09:27,338 DEBUG : BROWSER_OUTPUT: |5;Earley;786.7820613690008 13:09:27 INFO - 2015-11-20 13:09:27,338 DEBUG : BROWSER_OUTPUT: |6;Boyer;12168.674698795181 13:09:27 INFO - 2015-11-20 13:09:27,338 DEBUG : BROWSER_OUTPUT: |7;RegExp;26394.736842105263 13:09:27 INFO - 2015-11-20 13:09:27,338 DEBUG : BROWSER_OUTPUT: |8;Splay;610.5006105006105 13:09:27 INFO - 2015-11-20 13:09:27,338 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 13:09:27 INFO - 2015-11-20 13:09:27,338 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:09:27 INFO - 2015-11-20 13:09:27,338 DEBUG : BROWSER_OUTPUT: __startTimestamp1448053767330__endTimestamp 13:09:27 INFO - 2015-11-20 13:09:27,338 DEBUG : BROWSER_OUTPUT: 13:09:27 INFO - 2015-11-20 13:09:27,338 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:09:27 INFO - 2015-11-20 13:09:27,338 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:09:27 INFO - 2015-11-20 13:09:27,338 DEBUG : BROWSER_OUTPUT: 13:09:27 INFO - 2015-11-20 13:09:27,338 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.13 Median:163.13 stddev:0.00 (0.0%) 13:09:27 INFO - 2015-11-20 13:09:27,338 DEBUG : BROWSER_OUTPUT: Values: 163.1 13:09:27 INFO - 2015-11-20 13:09:27,338 DEBUG : BROWSER_OUTPUT: 13:09:27 INFO - 2015-11-20 13:09:27,338 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.99 Median:193.99 stddev:0.00 (0.0%) 13:09:27 INFO - 2015-11-20 13:09:27,339 DEBUG : BROWSER_OUTPUT: Values: 194.0 13:09:27 INFO - 2015-11-20 13:09:27,339 DEBUG : BROWSER_OUTPUT: 13:09:27 INFO - 2015-11-20 13:09:27,339 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:287.60 Median:287.60 stddev:0.00 (0.0%) 13:09:27 INFO - 2015-11-20 13:09:27,339 DEBUG : BROWSER_OUTPUT: Values: 287.6 13:09:27 INFO - 2015-11-20 13:09:27,339 DEBUG : BROWSER_OUTPUT: 13:09:27 INFO - 2015-11-20 13:09:27,339 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5020.00 Median:5020.00 stddev:0.00 (0.0%) 13:09:27 INFO - 2015-11-20 13:09:27,339 DEBUG : BROWSER_OUTPUT: Values: 5020.0 13:09:27 INFO - 2015-11-20 13:09:27,339 DEBUG : BROWSER_OUTPUT: 13:09:27 INFO - 2015-11-20 13:09:27,339 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1107.42 Median:1107.42 stddev:0.00 (0.0%) 13:09:27 INFO - 2015-11-20 13:09:27,339 DEBUG : BROWSER_OUTPUT: Values: 1107.4 13:09:27 INFO - 2015-11-20 13:09:27,339 DEBUG : BROWSER_OUTPUT: 13:09:27 INFO - 2015-11-20 13:09:27,339 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:786.78 Median:786.78 stddev:0.00 (0.0%) 13:09:27 INFO - 2015-11-20 13:09:27,339 DEBUG : BROWSER_OUTPUT: Values: 786.8 13:09:27 INFO - 2015-11-20 13:09:27,339 DEBUG : BROWSER_OUTPUT: 13:09:27 INFO - 2015-11-20 13:09:27,339 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12168.67 Median:12168.67 stddev:0.00 (0.0%) 13:09:27 INFO - 2015-11-20 13:09:27,339 DEBUG : BROWSER_OUTPUT: Values: 12168.7 13:09:27 INFO - 2015-11-20 13:09:27,340 DEBUG : BROWSER_OUTPUT: 13:09:27 INFO - 2015-11-20 13:09:27,340 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26394.74 Median:26394.74 stddev:0.00 (0.0%) 13:09:27 INFO - 2015-11-20 13:09:27,340 DEBUG : BROWSER_OUTPUT: Values: 26394.7 13:09:27 INFO - 2015-11-20 13:09:27,340 DEBUG : BROWSER_OUTPUT: 13:09:27 INFO - 2015-11-20 13:09:27,340 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:610.50 Median:610.50 stddev:0.00 (0.0%) 13:09:27 INFO - 2015-11-20 13:09:27,340 DEBUG : BROWSER_OUTPUT: Values: 610.5 13:09:27 INFO - 2015-11-20 13:09:27,340 DEBUG : BROWSER_OUTPUT: 13:09:27 INFO - 2015-11-20 13:09:27,340 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 13:09:27 INFO - 2015-11-20 13:09:27,340 DEBUG : BROWSER_OUTPUT: Values: 4840.6 13:09:27 INFO - 2015-11-20 13:09:27,340 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:09:27 INFO - 2015-11-20 13:09:27,340 DEBUG : BROWSER_OUTPUT: 13:09:28 INFO - 2015-11-20 13:09:28,173 INFO : Browser exited with error code: 0 13:09:28 INFO - 2015-11-20 13:09:28,190 INFO : Completed test v8_7 (00:00:38) 13:09:28 INFO - 2015-11-20 13:09:28,338 INFO : Completed test suite (00:20:08) 13:09:28 INFO - 2015-11-20 13:09:28,338 DEBUG : Working with test: dromaeo_css 13:09:28 INFO - 2015-11-20 13:09:28,338 DEBUG : Generating results file: dromaeo_css 13:09:28 INFO - 2015-11-20 13:09:28,339 DEBUG : Working with test: kraken 13:09:28 INFO - 2015-11-20 13:09:28,339 DEBUG : Generating results file: kraken 13:09:28 INFO - 2015-11-20 13:09:28,339 INFO : javascript benchmark 13:09:28 INFO - 2015-11-20 13:09:28,340 DEBUG : Working with test: v8_7 13:09:28 INFO - 2015-11-20 13:09:28,340 DEBUG : Generating results file: v8_7 13:09:28 INFO - 2015-11-20 13:09:28,340 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:09:28 INFO - 2015-11-20 13:09:28,393 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 13:09:28 INFO - 2015-11-20 13:09:28,393 DEBUG : process_Request line: dromaeo_css 6989.50 graph.html#tests=[[72,201,35]] 13:09:28 INFO - 2015-11-20 13:09:28,393 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:09:28 INFO - 2015-11-20 13:09:28,422 DEBUG : process_Request line: kraken 1502.50 graph.html#tests=[[232,201,35]] 13:09:28 INFO - 2015-11-20 13:09:28,422 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:09:28 INFO - 2015-11-20 13:09:28,452 DEBUG : process_Request line: v8_7 20976.20 graph.html#tests=[[230,201,35]] 13:09:28 INFO - 2015-11-20 13:09:28,453 INFO : javascript benchmark 13:09:28 INFO - 2015-11-20 13:09:28,457 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3147.669494703056, 3221.2752130770596, 3260.152360386299, 3272.8690852365908, 3280.458724310488, 5231.267622532839, 5356.3036805215315, 5356.3572371315395, 5425.538829199518, 5457.099578569531, 5350.759215835287, 5366.436524164956, 5384.40771515133, 5418.0, 5430.91853622195, 4838.733869637169, 4909.5581397674205, 4952.529509696573, 4956.876078098049, 4973.776180071905, 165.86486326623157, 4985.52637499437, 5041.798328066873, 5058.7976480940715, 5103.974480127613, 4975.0547395994645, 4986.551210391064, 4996.375453068366, 4999.775010124553, 5009.799608015694, 4985.975070124626, 4988.02733466974, 4993.0, 5006.249062640633, 5030.144875371196, 4753.667243292971, 4986.4265609455015, 4993.00139972007, 4994.976029913859, 5000.649954503187, 5140.665856719339, 5145.382554093495, 5178.766955487012, 5213.0, 5226.8693282667855, 5790.942090579082, 5791.65250084992, 5794.21778059965, 5797.420257974211, 5800.158976948361, 5582.637128586629, 5759.3376761672525, 5798.217240672498, 5805.4194580542035, 5815.767369305223, 5393.19102134679, 5441.374241962146, 5447.1829225616075, 5447.863803404907, 5459.590530710213, 5906.114082887515, 5922.289325280908, 5923.052311630118, 5925.555583331267, 5928.140419639129, 5599.440055994368, 5694.747155625756, 5715.914261286084, 5726.226959360516, 5754.424557544212, 5664.773409063591, 5707.258056452634, 5711.171880077449, 5717.685527295956, 5760.855978600569, 5733.856653583611, 5739.16782066598, 5741.827745167651, 5747.798827041033, 5748.913766293509, 5637.154426836008, 5738.397468265855, 5744.684042377626, 5758.452946970031, 5763.596548241667, 4441.600255976978, 4481.619062379734, 4484.170428470743, 4522.389477420572, 4527.185106680829, 4003.099302656937, 4019.4975628046495, 4063.91872162561, 4071.6742660587083, 4095.672346212296, 5289.550388216968, 5371.704556249366, 5406.675599464044, 5544.500994910478, 5552.555795536347, 5679.233303503974, 5692.260006199168, 5693.459121383462, 5699.344575373802, 5726.856828579319, 5438.483344082385, 5447.073997420448, 5448.182772584065, 5449.972750136224, 5467.152591348347, 4894.461609222983, 4991.650584459053, 5036.169032109661, 5067.037262920034, 5104.719240441737, 6048.395160483917, 6080.665563394055, 6084.300305464928, 6085.726142323606, 6092.543059270483, 5811.070228763378, 5840.678762668094, 5856.180134781049, 5859.033259512304, 5875.089361149029, 5879.529637629065, 5920.822375328747, 5973.372795856372, 6020.127081573235, 6031.974564323988, 5662.150677398423, 5684.0, 5692.715364231854, 5694.003549378925, 5708.971455142698, 5606.635568688022, 5654.773809047592, 5700.059490184073, 5724.713764311851, 5725.742341594555, 5517.200005999028, 5610.102383618601, 5615.606907516598, 5617.045102332695, 5666.065099258576, 5675.177099320658, 5687.0, 5688.232088667977, 5695.45893140151, 5700.25896633435, 5416.75624596902, 5597.580181486486, 5608.383077861514, 5609.21470994053, 5609.579281553818, 5572.804951826666, 5634.74643641029, 5648.4633959773755, 5650.491455769001, 5691.14632805066, 5594.888102237851, 5598.32820061579, 5603.495685388335, 5608.691521966168, 5612.635178713371], "unit": "ms", "name": "dojo.html", "value": 5304.304638381998}, {"lowerIsBetter": false, "replicates": [580.3413126101874, 588.8675048114175, 590.7046476761619, 603.2670305578721, 611.8776244751051, 31541.211469713267, 32142.0, 39388.0, 40499.79750101245, 40526.79736601313, 41862.7906860466, 42213.733587992334, 42415.151696966044, 42424.36363454551, 42464.0, 7581.583012934287, 8600.698975535857, 8850.690225842096, 8858.335624828163, 8860.734177974671, 7648.502847314907, 10476.633317833877, 10723.678289651283, 10728.78542429151, 10729.678109656723, 10369.740756481073, 10437.791244175112, 10477.895221047767, 10480.633177838778, 10493.108085812715, 7641.426892983049, 7809.453338266324, 10327.07056364927, 10432.426216558086, 10440.269181157322, 10444.373337599693, 10741.83887241692, 10742.0, 10742.248042637018, 10743.83884241737, 39645.801770991246, 39779.60220397817, 40089.191526804905, 40111.59888401108, 40116.197676046606, 3427.3316703242876, 3931.567527571965, 3945.270125026879, 3946.1515774108702, 3960.920781584352, 30561.0, 30905.227369315722, 30948.0, 30964.8451757742, 31941.52087718686, 3869.6517313441645, 3878.864239751595, 3913.5108111486065, 3913.6869050475893, 3981.3629819229072, 273061.0, 273662.0, 274685.0, 275072.999999998, 275159.0, 51381.743091285054, 53300.73349633227, 58690.0, 59407.702961484916, 60538.0, 53914.46085539173, 54334.45665543373, 54418.183727244126, 54563.635909101795, 54677.0, 15795.447159349367, 15976.121313327878, 15989.0, 15997.680046399008, 16002.839971600135, 11944.880551194377, 12028.09789265791, 12030.518779248732, 12037.337946413032, 12169.695757605954, 19555.41333759961, 20079.0, 20098.598028039356, 20118.0, 20143.899280503505, 7567.772966811004, 7752.186020467882, 7775.688972441039, 7806.024246969129, 7807.531548107132, 896.305363343401, 909.377076702461, 1007.8538611901233, 1012.2863381316155, 1075.930064545802, 27608.861955690092, 27805.582916256273, 27858.303542411602, 28069.157925262276, 28240.71759282422, 1034.6275340877278, 1039.101177481473, 1072.0726571515584, 1108.5953626926275, 1129.728865072393, 14590.489332873298, 14632.561023169323, 15098.773518397233, 15385.461508847136, 15461.690766184613, 244879.0, 249100.0, 249143.0, 249222.0, 249412.0, 51191.23213151806, 51646.22530662043, 51708.741456292475, 51731.448056558365, 51793.44619661341, 1311.8622544632867, 1325.8342707161605, 1336.2583766009764, 1339.4039652354804, 1339.9732005359838, 27750.167494975183, 28093.719062809112, 28679.283017923884, 28741.0, 28819.423611527232, 41779.7911010443, 45527.08945821131, 45884.770576146904, 45925.54074459212, 45993.77003114963, 245631.0, 419689.0, 426876.0, 427678.0, 427982.0, 29921.102366929026, 30506.0, 30530.542041869834, 30547.0, 30567.54148687727, 41782.79108604437, 42249.577504225796, 42495.0, 43472.130557388045, 43490.56509434992, 34394.528711267376, 35265.1183720409, 35722.0, 36353.81823090973, 36929.26141477209, 32213.51679724853, 32216.516752249205, 32397.19007024843, 32443.18892027718, 32564.674353257113, 31532.684673153894, 32160.678393215767, 32332.838335809112, 32432.35135297328, 32630.34739305248, 31572.0, 31723.20691982719, 32262.19344516406, 32311.838440807645, 32366.514502282957, 24666.753332466447, 25871.353216169748, 25914.0, 26016.609750853375, 26282.60576091322], "unit": "ms", "name": "ext.html", "value": 18679.75135681515}, {"lowerIsBetter": false, "replicates": [353.2352456930743, 354.0720775378064, 356.68967997841884, 357.6441440766438, 360.1248965015014, 14290.214038227894, 14328.355224014918, 16537.17314134293, 17632.294708211673, 18929.33747318844, 16007.35970561179, 16430.7535386969, 16559.83440165598, 16586.917065414655, 16976.15119244039, 4817.78319975602, 5470.070088085015, 5478.808241711541, 5479.698616576086, 5480.314960629921, 3941.4679018332445, 4067.2475592015426, 5407.729613519328, 5447.237386765836, 5751.7986870459545, 5771.3074431068335, 5812.505936995361, 5813.796517121901, 5821.67980761058, 5848.327442344121, 5759.078547432412, 5830.970845145768, 5973.910391344133, 5978.282606087298, 5989.670568118751, 5267.26258323835, 5283.815066472655, 5285.550728188108, 5294.0, 5301.840944771663, 18553.072346382625, 19935.50161245966, 20090.799092009038, 20326.79673203264, 20855.687164692543, 2088.5300807318386, 2156.6225910465764, 2175.8150557202657, 2252.9436764080865, 2332.2303639798824, 12989.740205195938, 13099.541516046987, 13188.274644894527, 13393.531226407127, 13629.931850340785, 1745.4327343613377, 1810.8682073703935, 1868.3647559829587, 1874.372085351409, 1900.277894400119, 58053.12920306199, 58462.0, 59816.0, 60449.0, 60549.78900422011, 9621.08599683029, 9905.752356191153, 9981.151602113756, 10066.647667331608, 10081.59673613062, 12948.417321220379, 13017.544385946447, 13021.153625014344, 13030.0, 13034.478620855249, 7845.293923546908, 7852.607369631495, 7855.253750893656, 7915.812628105715, 7918.722844700408, 7799.142094369615, 7812.414068944739, 7827.060752709711, 7833.2166783322355, 7870.252326029018, 5909.970450147808, 5960.672163031075, 6008.969955150284, 6023.759049638053, 6044.667543285162, 1666.1252842257911, 1720.9053502057507, 1745.4589077386051, 1750.6061136244243, 1766.434740882905, 851.8892543969245, 883.6553744039829, 923.8013827027087, 958.7842735384482, 993.6323560282742, 14455.204963727096, 16108.355665773237, 16664.58338541522, 17115.400960966308, 17462.301507939796, 840.2269911681268, 859.3597769661517, 881.9823603528022, 896.789254525186, 943.9716808495756, 8887.289016878634, 9324.300677449219, 9350.205232555309, 9433.198178154933, 9496.90503094974, 514201.0, 515731.0, 520993.0, 523321.0, 524285.0, 74420.25579744134, 80610.0, 80920.59539702264, 81827.0, 82043.0, 1163.4241050679968, 1174.1311429542077, 1186.7151883547886, 1186.8101103823346, 1189.2507720136432, 14518.20149891766, 15498.147601882005, 15517.068975861484, 15525.84474155244, 15787.68424631478, 34082.31835363329, 34566.13584660403, 34637.30725385529, 34736.82631586826, 34811.30377392488, 43089.78455107704, 43298.13403731971, 45277.0, 46183.30725039195, 46570.534294656616, 8827.293816494537, 9493.715188544355, 9502.287328450531, 9506.429614223169, 9509.381890177116, 11275.436228188393, 11303.095752339957, 16300.184990750178, 17967.011814349815, 18205.635887282446, 14392.136471811726, 14515.201663908165, 14667.413303467742, 14776.261186940825, 15000.0, 14289.499867504588, 14303.713925721218, 14600.488982885548, 14892.62768430798, 15127.848721512644, 11950.701232469259, 12428.75712428786, 13241.933790330986, 13844.653883652989, 13946.79079813824, 8690.782730431536, 9255.76860578491, 9257.537123143682, 9258.074192580689, 9607.471589062668, 9591.664291749756, 9709.805803884024, 13711.862881371058, 13768.518101866386, 14529.636759080684], "unit": "ms", "name": "jquery.html", "value": 8911.031003757915}, {"lowerIsBetter": false, "replicates": [1416.4829837109455, 1452.5279284232624, 1526.7557190849466, 1587.8174009988854, 1748.6327871147066, 7056.0, 7254.600996945166, 7637.656305466254, 7771.961140194306, 7783.066032076144, 7626.847463050735, 7698.576578288192, 7735.497192682472, 7751.6124193790365, 7754.030746156731, 1895.9572235270614, 1914.8276655101038, 2247.9887600562015, 2273.318004598622, 2273.57938781326, 2268.9886550567226, 2334.6731457595865, 2336.6261398176293, 2336.649502574619, 2337.719473663154, 2177.2379667116543, 2200.3508964855405, 2234.530748542808, 2239.54089411671, 2240.1599400224914, 1986.5927484865567, 2033.268023511542, 2149.3981685128188, 2241.2491815241915, 2247.5617254635354, 2207.55848830233, 2232.0, 2233.4304752288226, 2235.854669446481, 2237.518933429304, 7845.725399610987, 7890.723824666109, 7939.245771651684, 7943.324817390529, 7949.403794715419, 4607.700499467557, 4693.225617773063, 4693.624510039189, 4720.57514823664, 4721.811127554894, 3145.5438961350706, 3201.3917355702574, 3206.198450387403, 3208.98395508021, 3261.7390608751243, 1129.7458071933831, 1963.1950900130878, 1967.6950072738748, 1981.2471260920902, 1989.184434381911, 10758.731031724192, 10853.403062831541, 10857.294275872122, 10858.67423977282, 10874.0, 4080.0615858352153, 4132.049628585382, 4172.687048471377, 4212.494500659879, 4213.705040647125, 8641.740747777576, 8644.265237454762, 8645.524496152771, 8655.09121542229, 8662.82674346522, 4672.182368085571, 4672.649551283667, 4693.601043911238, 4701.247800351927, 4701.341812146302, 4293.527711951683, 4318.568143185719, 4336.219480493478, 4342.891427714269, 4350.282203436397, 3382.5095361172494, 3394.168428734976, 3399.4730816722954, 3422.264213194125, 3422.3839708852147, 1081.1080858291941, 1105.8120119579692, 1114.4650567727535, 1118.770652016351, 1122.9213955023233, 1027.0705011964185, 1040.089921318846, 1040.245821779204, 1158.507634255438, 1297.9935100324437, 6940.722371105099, 7057.400120989773, 7250.3112204340505, 7438.070241219848, 7442.0, 545.5008667069666, 552.2875490617059, 556.807901274068, 557.0780358506678, 559.0, 5557.166425036277, 5560.77756889728, 5623.184638227516, 5651.378348381675, 5656.8868622627315, 9147.131022552847, 9788.657396991071, 9820.558074886647, 9857.605695772088, 9872.35829671069, 9579.13787759091, 9582.137607615348, 9733.610655573839, 9739.805203895883, 9753.951230243803, 7248.601326926964, 7425.1832298447125, 7451.068616423056, 7512.812179695551, 7522.699092036367, 6860.382565569123, 6884.8967265490055, 6928.411085057826, 6946.583205007716, 6967.442604591722, 8445.0, 8491.83016339682, 8598.226159645661, 8624.137586241326, 8646.351523635878, 8646.783830404038, 8793.428427152214, 8794.824103518022, 8929.821403572023, 8931.0, 6529.967350163219, 6557.639329836905, 6574.605523668595, 6615.073889655356, 6649.401553859982, 7566.432517561315, 7595.5822429764685, 7632.923670763222, 7641.388688904985, 7647.044119485065, 7108.289171082851, 7134.250903655042, 7135.179454362607, 7163.283671632795, 7202.855942881218, 6846.178458585002, 6886.827829304308, 6909.516333856783, 7014.0531028310525, 7026.754063607749, 6211.440970312694, 6495.577787443801, 6968.059311993019, 7013.333733295329, 7015.088038554955, 6140.894638965029, 6424.229092508742, 6517.348265173445, 6518.837029074311, 6524.0, 6442.420182183439, 6461.547691661539, 6505.41451269388, 6516.218053833571, 6516.967415162894], "unit": "ms", "name": "mootools.html", "value": 4432.586010605184}, {"lowerIsBetter": false, "replicates": [295.33549513594414, 298.32876028934896, 301.8505839609394, 314.75291895861744, 319.8256949962271, 6060.181875446819, 6062.8787424251595, 6081.756729730811, 6089.725962331695, 6093.573449858512, 5931.555133364994, 5936.673482958447, 5939.1388248703915, 5943.643381397108, 5947.791827286046, 4488.798004089824, 4500.639948804096, 4505.301678239878, 4509.120721459317, 4510.684252102355, 4378.890527736816, 4455.688101832873, 4514.390557274775, 4514.480834704002, 4521.32180172975, 4369.082492676542, 4377.47470303564, 4387.319965405367, 4430.246858034142, 4468.240399132139, 4458.086092351093, 4458.308962110878, 4461.330800379953, 4465.151621191963, 4475.351074094238, 3785.0726571989762, 3850.287696776077, 3863.092173339263, 3865.5747867734526, 3867.0719027433493, 5564.944350556483, 5705.258316418881, 5716.742746576414, 5732.942670573282, 5755.568332375046, 5227.3988491323225, 5240.580753539708, 5247.580193584504, 5248.947510524884, 5254.553362964152, 5979.043353063489, 6142.26292844857, 6306.87386252277, 6319.842003949892, 6330.17707698001, 4274.850380236677, 4325.134973005412, 4333.58830911063, 4333.653307735373, 4349.412829268072, 6555.6066636001515, 6556.147700798913, 6556.147700798913, 6559.573627714183, 6562.343765623399, 4429.68992170545, 4430.180416622935, 4430.8449204277695, 4435.0, 4437.933430998538, 4387.978060109679, 4483.14820184164, 4498.392716983165, 4501.167284052461, 4505.639548836085, 5191.195364718399, 5229.08491014071, 5232.424433312332, 5243.842684719464, 5248.527632513016, 6384.904226436607, 6391.872162556723, 6392.872142557123, 6394.744210231539, 6394.784990851724, 1575.9763603545955, 1606.3654856331916, 1606.5421354913794, 1607.5900645335364, 1608.1637548474728, 1027.4708525109575, 1036.1762398892897, 1042.2495803021811, 1044.1490185498947, 1092.055372103141, 6065.059915713072, 6149.41580549847, 6158.476529494954, 6159.291681456601, 6160.568760186834, 6533.901991470132, 6538.869222615521, 6545.247296560861, 6547.639879806561, 6584.604923704593, 5983.850403739942, 6125.295591007002, 6125.754969801158, 6133.478654314344, 6140.600860944024, 3521.1197200699826, 3526.7883926964464, 3549.9112522186633, 3555.2356243407276, 3556.76881002734, 6756.459483241329, 6761.72953081881, 6764.898526522106, 6767.796966091025, 6767.864642707217, 6489.740410383626, 6630.502712296597, 6631.171103612049, 6632.336766323426, 6643.036759669821, 6760.594364338155, 6767.492438067165, 6770.221424536143, 6777.49168812341, 6777.525573209828, 6394.0, 6509.902351464637, 6516.706748196438, 6524.445422139172, 6562.5406221564035, 6590.275069742229, 6594.307597702172, 6605.207375114825, 6607.0, 6619.6028238303925, 6905.689243984133, 6920.204176519765, 6922.550034247758, 6926.411255043377, 6930.549514281757, 4348.326009468537, 4441.20058389493, 4455.376247325442, 4455.5098939117315, 4456.866294011184, 6568.047633093271, 6607.636579988147, 6611.504137189634, 6621.735130594722, 6626.56927299724, 6428.935710643021, 6430.099786029866, 6435.774747883802, 6439.06633538125, 6439.581427207217, 6304.747810087545, 6383.1382763326355, 6402.391772781578, 6469.741210351722, 6482.675866206765, 6317.241930968313, 6327.715252813727, 6358.046293056079, 6363.96818015907, 6367.968160159169, 6512.73949042033, 6518.543701940818, 6522.412982831568, 6523.793098276834, 6525.673716314261, 6204.410580994799, 6340.365963403623, 6344.080108384166, 6344.619322840645, 6362.872742545216], "unit": "ms", "name": "prototype.html", "value": 4758.121159663626}, {"lowerIsBetter": false, "replicates": [721.3219573600815, 785.9960700196498, 822.5475988206485, 854.5769843927261, 860.0797147052655, 13390.866091339083, 13930.791038134435, 13960.790588141173, 13961.37173827179, 13966.371513281902, 12581.308028058453, 12613.243205407682, 12636.873631263685, 12672.493100275979, 12691.3654317284, 669.8693754717832, 674.871774362872, 794.0709370037071, 800.7397595781365, 817.8159914019328, 803.4536515169682, 814.9755507334789, 822.0998007182126, 822.1080128061031, 822.1655020154518, 850.2900078434515, 852.9360297977645, 858.0732808566733, 861.0098386855135, 862.211076864668, 702.5433468245656, 709.0180100560734, 837.4891316297054, 850.0606829453488, 854.0733304364771, 629.4177885455981, 629.8960671489199, 630.0549176235646, 630.612173513286, 630.9022101574263, 13325.666858328523, 13424.865751342459, 13445.932770336183, 13468.326583670778, 13478.730425391535, 11229.3262404256, 11604.767904641943, 11749.29504229749, 11886.167968242227, 11935.820962685566, 10134.13859821916, 10163.237757168168, 10275.948620256926, 10363.274570780048, 10392.220583456272, 3560.181158333598, 3561.3411518869093, 3617.692496137805, 3621.7826930384263, 3700.40793473043, 45312.54687453116, 45634.771826140655, 45636.0, 45778.31332530015, 45927.081458370645, 9690.660826871026, 9906.900930990598, 10066.59733610662, 10385.428801415843, 10395.064444200058, 17348.913255433643, 17515.737263940795, 17525.123743812757, 17539.0, 17578.296868125388, 7228.783136505913, 7477.887831682529, 7511.774646760606, 7611.581363024976, 7696.769096927102, 4202.936955945664, 4203.47456567929, 4240.893977650521, 4247.915041699149, 4283.678724095706, 3009.8946536871103, 3016.834074125944, 3030.5151175811766, 3032.5451182322386, 3035.8330291833718, 509.3353174107751, 525.414163208028, 532.0954377558166, 532.478171392038, 535.0769921884795, 569.6952130610103, 608.9725962331705, 624.316373570939, 650.4601181019742, 671.8891382921763, 8283.62723677436, 8352.457090289112, 8354.540500272422, 8386.958065209636, 8554.18735220153, 542.5252903709254, 586.3784388548153, 651.5919802535849, 683.4122654517112, 715.1704023332909, 3824.674902633252, 3825.885223443301, 3845.538535375773, 3945.881623551298, 3977.622125898035, 58849.0, 59209.70395147997, 59284.70357648184, 59287.0, 59391.70304148538, 53244.73377633087, 53253.46746532562, 53987.0, 54367.45632543703, 54776.17835732467, 48844.0, 48957.0, 49386.506134938194, 49488.50511494839, 49623.751881240365, 8197.877031844408, 8277.420580559303, 8612.181842725182, 8782.780430489289, 8954.373193876367, 37014.25971480609, 37938.62061379351, 37946.810265948494, 39110.0, 40375.19249614933, 48751.5124848747, 48794.51205488042, 48945.14767932564, 49034.50965490299, 49423.0, 11511.481983310938, 11565.884341156481, 11666.76666466649, 11886.108541859223, 12022.63932082039, 11263.887361126612, 11710.765784684429, 11822.290662560274, 12546.0, 12690.048246381373, 10690.83963740529, 10783.892161078289, 10930.070943969851, 11206.49570769301, 11207.719807004563, 10160.644377446753, 10307.484625768831, 10883.074938630305, 10903.563857445613, 10941.781164376509, 7180.676869540987, 9523.333366664545, 10934.343939363345, 11417.31496110236, 11706.648800535997, 9614.51927403613, 9626.229901607994, 9798.902010979798, 10216.693499195037, 10406.843897341394, 9729.173020293072, 9751.0, 9853.408795472295, 9905.603775848886, 9918.0], "unit": "ms", "name": "yui.html", "value": 6260.585209587129}], "name": "dromaeo_css", "value": 6989.494928616767}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 109.0, 103.0, 109.0, 111.0, 109.0, 99.0, 109.0, 108.0, 106.0], "unit": "ms", "name": "ai-astar", "value": 107.0}, {"lowerIsBetter": true, "replicates": [150.0, 125.0, 151.0, 165.0, 126.0, 150.0, 153.0, 125.0, 162.0, 126.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.3}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 160.0, 160.0, 162.0, 160.0, 160.0, 163.0, 162.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 80.0, 93.0, 71.0, 71.0, 71.0, 102.0, 90.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 79.2}, {"lowerIsBetter": true, "replicates": [91.0, 91.0, 132.0, 89.0, 90.0, 91.0, 147.0, 90.0, 91.0, 135.0], "unit": "ms", "name": "audio-oscillator", "value": 104.7}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 60.0, 60.0, 59.0, 60.0, 59.0, 70.0, 58.0, 58.0], "unit": "ms", "name": "json-parse-financial", "value": 60.2}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 68.0, 70.0, 67.0, 83.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 85.0, 86.0, 84.0, 84.0, 85.0, 85.0, 87.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.2}, {"lowerIsBetter": true, "replicates": [120.0, 122.0, 125.0, 121.0, 136.0, 120.0, 122.0, 121.0, 120.0, 125.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.2}, {"lowerIsBetter": true, "replicates": [145.0, 155.0, 155.0, 142.0, 169.0, 153.0, 143.0, 149.0, 151.0, 141.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 150.3}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 66.0, 70.0, 67.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1502.5000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.1321370309951], "unit": "score", "name": "Richards", "value": 216.40126}, {"lowerIsBetter": false, "replicates": [193.98642095053347], "unit": "score", "name": "DeltaBlue", "value": 340.8382899999999}, {"lowerIsBetter": false, "replicates": [287.60425654299684], "unit": "score", "name": "Encrypt", "value": 925.5113369999998}, {"lowerIsBetter": false, "replicates": [5020.0], "unit": "score", "name": "Decrypt", "value": 53.0241035856574}, {"lowerIsBetter": false, "replicates": [1107.4197120708748], "unit": "score", "name": "RayTrace", "value": 668.2100670000003}, {"lowerIsBetter": false, "replicates": [786.7820613690008], "unit": "score", "name": "Earley", "value": 847.0744729999998}, {"lowerIsBetter": false, "replicates": [12168.674698795181], "unit": "score", "name": "Boyer", "value": 54.768741584158384}, {"lowerIsBetter": false, "replicates": [26394.736842105263], "unit": "score", "name": "RegExp", "value": 34.51388833499503}, {"lowerIsBetter": false, "replicates": [610.5006105006105], "unit": "score", "name": "Splay", "value": 133.48225799999997}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20976.196604469893}]} 13:09:28 INFO - RETURN: dromaeo_css: 6989.50 13:09:28 INFO - RETURN: kraken: 1502.50 13:09:28 INFO - RETURN: v8_7: 20976.20 13:09:28 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20976.20"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1502.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6989.50"}}} 13:09:28 INFO - Return code: 0 13:09:28 INFO - # TBPL SUCCESS # 13:09:28 INFO - Running post-action listener: _resource_record_post_action 13:09:28 INFO - Running post-run listener: _resource_record_post_run 13:09:29 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 4096; Write bytes: 511700992; Read time: 24; Write time: 475804 13:09:29 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 239493120; Read time: 0; Write time: 343804 13:09:29 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 4096; Write bytes: 272195584; Read time: 24; Write time: 132000 13:09:29 INFO - Running post-run listener: _upload_blobber_files 13:09:29 INFO - Blob upload gear active. 13:09:29 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:09:29 INFO - Copying logs to upload dir... 13:09:29 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1253.371853 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2015-11-20 13:09:29.539769) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 13:09:29.543615) ========= 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=6587686cb2da90a5f91b3170000001be-1448052444.742510-424514314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/WCICnORvQFCwGij-EsGXSA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.008702 build_url: 'https://queue.taskcluster.net/v1/task/WCICnORvQFCwGij-EsGXSA/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-20 13:09:29.591997) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 13:09:29.592356) ========= 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=6587686cb2da90a5f91b3170000001be-1448052444.742510-424514314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 13:09:29.642465) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 13:09:29.642801) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 13:09:29.643167) ========= ========= Total master_lag: 0.21 =========