builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-004 starttime: 1448040657.39 results: success (0) buildid: 20151120073302 builduid: 1715216e2ed440a0a0a7ad70b9c028ca revision: 14bd25c639127766d0c29c651e764fe53a3144a2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 09:30:57.392490) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 09:30:57.393436) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 09:30:57.394146) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1448040511.715958-1160632041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006644 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 09:30:57.422467) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 09:30:57.422789) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 09:30:57.436755) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 09:30:57.437219) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1448040511.715958-1160632041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004554 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 09:30:57.488973) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 09:30:57.489546) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 09:30:57.490227) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 09:30:57.490752) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1448040511.715958-1160632041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 09:30:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2015-11-20 09:30:57 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.186076 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 09:30:57.692890) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 09:30:57.693515) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1448040511.715958-1160632041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013306 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 09:30:57.744485) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 09:30:57.744850) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 14bd25c639127766d0c29c651e764fe53a3144a2 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 14bd25c639127766d0c29c651e764fe53a3144a2 --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=8e92d6ac3b8b0dffa3775d33000001f9-1448040511.715958-1160632041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 09:30:57,925 truncating revision to first 12 chars 2015-11-20 09:30:57,925 Setting DEBUG logging. 2015-11-20 09:30:57,925 attempt 1/10 2015-11-20 09:30:57,925 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/14bd25c63912?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 09:30:58,688 unpacking tar archive at: mozilla-inbound-14bd25c63912/testing/mozharness/ program finished with exit code 0 elapsedTime=1.079714 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 09:30:58.838343) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 09:30:58.838694) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 09:30:58.847212) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 09:30:58.847496) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 09:30:58.847937) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2015-11-20 09:30:58.848264) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8e92d6ac3b8b0dffa3775d33000001f9-1448040511.715958-1160632041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:30:59 INFO - MultiFileLogger online at 20151120 09:30:59 in /builds/slave/test-pgo 09:30:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 09:30:59 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:30:59 INFO - {'append_to_log': False, 09:30:59 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:30:59 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 09:30:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:30:59 INFO - 'branch': 'Mozilla-Inbound', 09:30:59 INFO - 'buildbot_json_path': 'buildprops.json', 09:30:59 INFO - 'config_files': ('talos/linux_config.py',), 09:30:59 INFO - 'default_actions': ('clobber', 09:30:59 INFO - 'read-buildbot-config', 09:30:59 INFO - 'download-and-extract', 09:30:59 INFO - 'populate-webroot', 09:30:59 INFO - 'create-virtualenv', 09:30:59 INFO - 'install', 09:30:59 INFO - 'run-tests'), 09:30:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:30:59 INFO - 'download_minidump_stackwalk': True, 09:30:59 INFO - 'download_symbols': 'ondemand', 09:30:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:30:59 INFO - 'tooltool.py': '/tools/tooltool.py', 09:30:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:30:59 INFO - '/tools/misc-python/virtualenv.py')}, 09:30:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:30:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:30:59 INFO - 'installer_path': 'installer.exe', 09:30:59 INFO - 'log_level': 'info', 09:30:59 INFO - 'log_name': 'talos', 09:30:59 INFO - 'log_to_console': True, 09:30:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:30:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:30:59 INFO - 'opt_config_files': (), 09:30:59 INFO - 'pip_index': False, 09:30:59 INFO - 'sps_profile': False, 09:30:59 INFO - 'sps_profile_interval': 0, 09:30:59 INFO - 'suite': 'dromaeojs-e10s', 09:30:59 INFO - 'system_bits': '64', 09:30:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:30:59 INFO - 'title': 'talos-linux64-ix-004', 09:30:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:30:59 INFO - 'use_talos_json': True, 09:30:59 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:30:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:30:59 INFO - 'work_dir': 'build'} 09:30:59 INFO - ##### 09:30:59 INFO - ##### Running clobber step. 09:30:59 INFO - ##### 09:30:59 INFO - Running pre-action listener: _resource_record_pre_action 09:30:59 INFO - Running main action method: clobber 09:30:59 INFO - rmtree: /builds/slave/test-pgo/build 09:30:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:31:00 INFO - Running post-action listener: _resource_record_post_action 09:31:00 INFO - ##### 09:31:00 INFO - ##### Running read-buildbot-config step. 09:31:00 INFO - ##### 09:31:00 INFO - Running pre-action listener: _resource_record_pre_action 09:31:00 INFO - Running main action method: read_buildbot_config 09:31:00 INFO - Using buildbot properties: 09:31:00 INFO - { 09:31:00 INFO - "properties": { 09:31:00 INFO - "buildnumber": 202, 09:31:00 INFO - "product": "firefox", 09:31:00 INFO - "script_repo_revision": "production", 09:31:00 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 09:31:00 INFO - "repository": "", 09:31:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 09:31:00 INFO - "buildid": "20151120073302", 09:31:00 INFO - "slavename": "talos-linux64-ix-004", 09:31:00 INFO - "pgo_build": "True", 09:31:00 INFO - "basedir": "/builds/slave/test-pgo", 09:31:00 INFO - "project": "", 09:31:00 INFO - "platform": "ubuntu64_hw", 09:31:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:31:00 INFO - "slavebuilddir": "test", 09:31:00 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 09:31:00 INFO - "branch": "mozilla-inbound", 09:31:00 INFO - "repo_path": "integration/mozilla-inbound", 09:31:00 INFO - "stage_platform": "linux64-pgo", 09:31:00 INFO - "builduid": "1715216e2ed440a0a0a7ad70b9c028ca", 09:31:00 INFO - "revision": "14bd25c639127766d0c29c651e764fe53a3144a2" 09:31:00 INFO - }, 09:31:00 INFO - "sourcestamp": { 09:31:00 INFO - "repository": "", 09:31:00 INFO - "hasPatch": false, 09:31:00 INFO - "project": "", 09:31:00 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 09:31:00 INFO - "changes": [ 09:31:00 INFO - { 09:31:00 INFO - "category": null, 09:31:00 INFO - "files": [ 09:31:00 INFO - { 09:31:00 INFO - "url": null, 09:31:00 INFO - "name": "https://queue.taskcluster.net/v1/task/tBW8e_9rRTyfx6v-MFAxoA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:31:00 INFO - } 09:31:00 INFO - ], 09:31:00 INFO - "repository": "", 09:31:00 INFO - "rev": "14bd25c639127766d0c29c651e764fe53a3144a2", 09:31:00 INFO - "who": "sendchange", 09:31:00 INFO - "when": 1448040610, 09:31:00 INFO - "number": 6689619, 09:31:00 INFO - "comments": "", 09:31:00 INFO - "project": "", 09:31:00 INFO - "at": "Fri 20 Nov 2015 09:30:10", 09:31:00 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 09:31:00 INFO - "revlink": "", 09:31:00 INFO - "properties": [ 09:31:00 INFO - [ 09:31:00 INFO - "buildid", 09:31:00 INFO - "20151120073302", 09:31:00 INFO - "Change" 09:31:00 INFO - ], 09:31:00 INFO - [ 09:31:00 INFO - "builduid", 09:31:00 INFO - "1715216e2ed440a0a0a7ad70b9c028ca", 09:31:00 INFO - "Change" 09:31:00 INFO - ], 09:31:00 INFO - [ 09:31:00 INFO - "pgo_build", 09:31:00 INFO - "True", 09:31:00 INFO - "Change" 09:31:00 INFO - ] 09:31:00 INFO - ], 09:31:00 INFO - "revision": "14bd25c639127766d0c29c651e764fe53a3144a2" 09:31:00 INFO - } 09:31:00 INFO - ], 09:31:00 INFO - "revision": "14bd25c639127766d0c29c651e764fe53a3144a2" 09:31:00 INFO - } 09:31:00 INFO - } 09:31:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/tBW8e_9rRTyfx6v-MFAxoA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:31:00 INFO - Running post-action listener: _resource_record_post_action 09:31:00 INFO - ##### 09:31:00 INFO - ##### Running download-and-extract step. 09:31:00 INFO - ##### 09:31:00 INFO - Running pre-action listener: _resource_record_pre_action 09:31:00 INFO - Running main action method: download_and_extract 09:31:00 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:31: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')]} 09:31:00 INFO - https://queue.taskcluster.net/v1/task/tBW8e_9rRTyfx6v-MFAxoA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:31:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tBW8e_9rRTyfx6v-MFAxoA/artifacts/public/build/test_packages.json 09:31:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tBW8e_9rRTyfx6v-MFAxoA/artifacts/public/build/test_packages.json 09:31:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tBW8e_9rRTyfx6v-MFAxoA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:31:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tBW8e_9rRTyfx6v-MFAxoA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:31:03 INFO - Downloaded 1302 bytes. 09:31:03 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:31:03 INFO - Using the following test package requirements: 09:31:03 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:31:03 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:31:03 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:31:03 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:31:03 INFO - u'jsshell-linux-x86_64.zip'], 09:31:03 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:31:03 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:31:03 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:31:03 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:31:03 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:31:03 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:31:03 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:31:03 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:31:03 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:31:03 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:31:03 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:31:03 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:31:03 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:03 INFO - https://queue.taskcluster.net/v1/task/tBW8e_9rRTyfx6v-MFAxoA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:31:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tBW8e_9rRTyfx6v-MFAxoA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:31:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tBW8e_9rRTyfx6v-MFAxoA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:31:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tBW8e_9rRTyfx6v-MFAxoA/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 09:31:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tBW8e_9rRTyfx6v-MFAxoA/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 09:31:05 INFO - Downloaded 22523591 bytes. 09:31:05 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 09:31:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:31:05 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 09:31:06 INFO - Return code: 0 09:31:06 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 09:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:06 INFO - https://queue.taskcluster.net/v1/task/tBW8e_9rRTyfx6v-MFAxoA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:31:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tBW8e_9rRTyfx6v-MFAxoA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:31:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tBW8e_9rRTyfx6v-MFAxoA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:31:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tBW8e_9rRTyfx6v-MFAxoA/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 09:31:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tBW8e_9rRTyfx6v-MFAxoA/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 09:31:07 INFO - Downloaded 22523591 bytes. 09:31:07 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 09:31:07 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:31:07 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 09:31:09 INFO - Return code: 0 09:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:09 INFO - https://queue.taskcluster.net/v1/task/tBW8e_9rRTyfx6v-MFAxoA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:31:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tBW8e_9rRTyfx6v-MFAxoA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:31:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tBW8e_9rRTyfx6v-MFAxoA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:31:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tBW8e_9rRTyfx6v-MFAxoA/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 09:31:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tBW8e_9rRTyfx6v-MFAxoA/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 09:31:10 INFO - Downloaded 11130997 bytes. 09:31:10 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 09:31:10 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:31:10 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 09:31:10 INFO - Return code: 0 09:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:10 INFO - https://queue.taskcluster.net/v1/task/tBW8e_9rRTyfx6v-MFAxoA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:31:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tBW8e_9rRTyfx6v-MFAxoA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:31:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tBW8e_9rRTyfx6v-MFAxoA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:31:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tBW8e_9rRTyfx6v-MFAxoA/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 09:31:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tBW8e_9rRTyfx6v-MFAxoA/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 09:31:11 INFO - Downloaded 57437573 bytes. 09:31:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/tBW8e_9rRTyfx6v-MFAxoA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:31:11 INFO - mkdir: /builds/slave/test-pgo/properties 09:31:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:31:11 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:31:11 INFO - Contents: 09:31:11 INFO - build_url:https://queue.taskcluster.net/v1/task/tBW8e_9rRTyfx6v-MFAxoA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:31:11 INFO - Running post-action listener: _resource_record_post_action 09:31:11 INFO - Running post-action listener: set_extra_try_arguments 09:31:11 INFO - ##### 09:31:11 INFO - ##### Running populate-webroot step. 09:31:11 INFO - ##### 09:31:11 INFO - Running pre-action listener: _resource_record_pre_action 09:31:11 INFO - Running main action method: populate_webroot 09:31:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:31:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:31:11 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:31:11 INFO - '../fennec_ids.txt'], 09:31:11 INFO - 'tests': ['tcheck2']}, 09:31:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:31:11 INFO - '--tppagecycles', 09:31:11 INFO - '7'], 09:31:11 INFO - 'tests': ['tsvgm']}}, 09:31:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:31:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:31:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:31:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:31:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:31:11 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:31:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:31:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:11 INFO - 'talos_options': ['--e10s'], 09:31:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:31:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:11 INFO - 'tests': ['damp', 'tps']}, 09:31:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:11 INFO - 'talos_options': ['--e10s'], 09:31:11 INFO - 'tests': ['damp', 'tps']}, 09:31:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:31:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:31:11 INFO - 'other': {'tests': ['a11yr', 09:31:11 INFO - 'ts_paint', 09:31:11 INFO - 'tpaint', 09:31:11 INFO - 'sessionrestore', 09:31:11 INFO - 'sessionrestore_no_auto_restore']}, 09:31:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:31:11 INFO - 'tests': ['a11yr', 09:31:11 INFO - 'ts_paint', 09:31:11 INFO - 'tpaint', 09:31:11 INFO - 'sessionrestore', 09:31:11 INFO - 'sessionrestore_no_auto_restore']}, 09:31:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:31:11 INFO - 'tests': ['a11yr', 09:31:11 INFO - 'ts_paint', 09:31:11 INFO - 'tpaint', 09:31:11 INFO - 'sessionrestore', 09:31:11 INFO - 'sessionrestore_no_auto_restore']}, 09:31:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:31:11 INFO - 'tests': ['a11yr', 09:31:11 INFO - 'ts_paint', 09:31:11 INFO - 'tpaint', 09:31:11 INFO - 'sessionrestore', 09:31:11 INFO - 'sessionrestore_no_auto_restore']}, 09:31:11 INFO - 'other_l64': {'tests': ['a11yr', 09:31:11 INFO - 'ts_paint', 09:31:11 INFO - 'tpaint', 09:31:11 INFO - 'sessionrestore', 09:31:11 INFO - 'sessionrestore_no_auto_restore']}, 09:31:11 INFO - 'other_nol64': {'tests': ['a11yr', 09:31:11 INFO - 'ts_paint', 09:31:11 INFO - 'tpaint', 09:31:11 INFO - 'sessionrestore', 09:31:11 INFO - 'sessionrestore_no_auto_restore']}, 09:31:11 INFO - 'svgr': {'tests': ['tsvgx', 09:31:11 INFO - 'tsvgr_opacity', 09:31:11 INFO - 'tart', 09:31:11 INFO - 'tscrollx', 09:31:11 INFO - 'cart']}, 09:31:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:31:11 INFO - 'tests': ['tsvgx', 09:31:11 INFO - 'tsvgr_opacity', 09:31:11 INFO - 'tart', 09:31:11 INFO - 'tscrollx', 09:31:11 INFO - 'cart']}, 09:31:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:11 INFO - 'tests': ['tp5o']}, 09:31:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:11 INFO - 'talos_options': ['--e10s'], 09:31:11 INFO - 'tests': ['tp5o']}, 09:31:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:11 INFO - 'talos_options': ['--xperf_path', 09:31:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:31:11 INFO - 'tests': ['tp5n']}, 09:31:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:11 INFO - 'talos_options': ['--e10s', 09:31:11 INFO - '--xperf_path', 09:31:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:31:11 INFO - 'tests': ['tp5n']}}, 09:31:11 INFO - 'talos.zip': {'path': '', 09:31:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:31:11 INFO - Running post-action listener: _resource_record_post_action 09:31:11 INFO - ##### 09:31:11 INFO - ##### Running create-virtualenv step. 09:31:11 INFO - ##### 09:31:11 INFO - Running pre-action listener: _resource_record_pre_action 09:31:11 INFO - Running main action method: create_virtualenv 09:31:11 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:31:11 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 09:31:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:31:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:31:11 INFO - Using real prefix '/usr' 09:31:11 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:31:12 INFO - Installing distribute.............................................................................................................................................................................................done. 09:31:14 INFO - Installing pip.................done. 09:31:14 INFO - Return code: 0 09:31:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:31:14 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')]} 09:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:14 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')]} 09:31:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:14 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 0x7f02c0adfc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aaf7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af3d70>, '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 0x1af4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af4fb0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1448040511.715958-1160632041', '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 09:31:14 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 09:31:14 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 09:31:14 INFO - Using env: {'DISPLAY': ':0', 09:31:14 INFO - 'HOME': '/home/cltbld', 09:31:14 INFO - 'LANG': 'en_US.UTF-8', 09:31:14 INFO - 'LANGUAGE': 'en_US:en', 09:31:14 INFO - 'LOGNAME': 'cltbld', 09:31:14 INFO - 'MAIL': '/var/mail/cltbld', 09:31:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:14 INFO - 'MOZ_NO_REMOTE': '1', 09:31:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:14 INFO - 'NO_EM_RESTART': '1', 09:31:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:31:14 INFO - 'PWD': '/builds/slave/test-pgo', 09:31:14 INFO - 'SHELL': '/bin/bash', 09:31:14 INFO - 'SHLVL': '1', 09:31:14 INFO - 'TERM': 'linux', 09:31:14 INFO - 'TMOUT': '86400', 09:31:14 INFO - 'USER': 'cltbld', 09:31:14 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448040511.715958-1160632041', 09:31:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:14 INFO - '_': '/tools/buildbot/bin/python'} 09:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:14 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 09:31:14 INFO - Cleaning up... 09:31:14 INFO - Return code: 0 09:31:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:31:14 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')]} 09:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:14 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')]} 09:31:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:14 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 0x7f02c0adfc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aaf7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af3d70>, '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 0x1af4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af4fb0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1448040511.715958-1160632041', '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 09:31:14 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 09:31:14 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 09:31:14 INFO - Using env: {'DISPLAY': ':0', 09:31:14 INFO - 'HOME': '/home/cltbld', 09:31:14 INFO - 'LANG': 'en_US.UTF-8', 09:31:14 INFO - 'LANGUAGE': 'en_US:en', 09:31:14 INFO - 'LOGNAME': 'cltbld', 09:31:14 INFO - 'MAIL': '/var/mail/cltbld', 09:31:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:14 INFO - 'MOZ_NO_REMOTE': '1', 09:31:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:14 INFO - 'NO_EM_RESTART': '1', 09:31:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:31:14 INFO - 'PWD': '/builds/slave/test-pgo', 09:31:14 INFO - 'SHELL': '/bin/bash', 09:31:14 INFO - 'SHLVL': '1', 09:31:14 INFO - 'TERM': 'linux', 09:31:14 INFO - 'TMOUT': '86400', 09:31:14 INFO - 'USER': 'cltbld', 09:31:14 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448040511.715958-1160632041', 09:31:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:14 INFO - '_': '/tools/buildbot/bin/python'} 09:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:14 INFO - Downloading/unpacking psutil>=0.7.1 09:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:16 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 09:31:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:31:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:31:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:31:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:31:16 INFO - Installing collected packages: psutil 09:31:16 INFO - Running setup.py install for psutil 09:31:16 INFO - building 'psutil._psutil_linux' extension 09:31:16 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 09:31:16 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 09:31:16 INFO - building 'psutil._psutil_posix' extension 09:31:16 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 09:31:17 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 09:31:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:31:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:31:17 INFO - Successfully installed psutil 09:31:17 INFO - Cleaning up... 09:31:17 INFO - Return code: 0 09:31:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:31:17 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')]} 09:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:17 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')]} 09:31:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:17 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 0x7f02c0adfc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aaf7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af3d70>, '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 0x1af4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af4fb0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1448040511.715958-1160632041', '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 09:31:17 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 09:31:17 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 09:31:17 INFO - Using env: {'DISPLAY': ':0', 09:31:17 INFO - 'HOME': '/home/cltbld', 09:31:17 INFO - 'LANG': 'en_US.UTF-8', 09:31:17 INFO - 'LANGUAGE': 'en_US:en', 09:31:17 INFO - 'LOGNAME': 'cltbld', 09:31:17 INFO - 'MAIL': '/var/mail/cltbld', 09:31:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:17 INFO - 'MOZ_NO_REMOTE': '1', 09:31:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:17 INFO - 'NO_EM_RESTART': '1', 09:31:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:31:17 INFO - 'PWD': '/builds/slave/test-pgo', 09:31:17 INFO - 'SHELL': '/bin/bash', 09:31:17 INFO - 'SHLVL': '1', 09:31:17 INFO - 'TERM': 'linux', 09:31:17 INFO - 'TMOUT': '86400', 09:31:17 INFO - 'USER': 'cltbld', 09:31:17 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448040511.715958-1160632041', 09:31:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:17 INFO - '_': '/tools/buildbot/bin/python'} 09:31:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:31:17 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 09:31:17 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 09:31:17 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 09:31:17 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 09:31:17 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 09:31:17 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 09:31:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:31:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:31:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:31:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:31:19 INFO - Installing collected packages: mozsystemmonitor 09:31:19 INFO - Running setup.py install for mozsystemmonitor 09:31:19 INFO - Successfully installed mozsystemmonitor 09:31:19 INFO - Cleaning up... 09:31:19 INFO - Return code: 0 09:31:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:31: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')]} 09:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31: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')]} 09:31:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f02c0adfc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aaf7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af3d70>, '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 0x1af4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af4fb0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1448040511.715958-1160632041', '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 09:31:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 09:31:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:31:19 INFO - Using env: {'DISPLAY': ':0', 09:31:19 INFO - 'HOME': '/home/cltbld', 09:31:19 INFO - 'LANG': 'en_US.UTF-8', 09:31:19 INFO - 'LANGUAGE': 'en_US:en', 09:31:19 INFO - 'LOGNAME': 'cltbld', 09:31:19 INFO - 'MAIL': '/var/mail/cltbld', 09:31:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:19 INFO - 'MOZ_NO_REMOTE': '1', 09:31:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:19 INFO - 'NO_EM_RESTART': '1', 09:31:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:31:19 INFO - 'PWD': '/builds/slave/test-pgo', 09:31:19 INFO - 'SHELL': '/bin/bash', 09:31:19 INFO - 'SHLVL': '1', 09:31:19 INFO - 'TERM': 'linux', 09:31:19 INFO - 'TMOUT': '86400', 09:31:19 INFO - 'USER': 'cltbld', 09:31:19 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448040511.715958-1160632041', 09:31:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:19 INFO - '_': '/tools/buildbot/bin/python'} 09:31:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:19 INFO - Downloading/unpacking blobuploader==1.2.4 09:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:21 INFO - Downloading blobuploader-1.2.4.tar.gz 09:31:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:31:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:31:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:31:21 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 09:31:21 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 09:31:21 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 09:31:21 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 09:31:21 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 09:31:21 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 09:31:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:31:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:31:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:31:21 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 09:31:21 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 09:31:21 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 09:31:21 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 09:31:21 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 09:31:21 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 09:31:21 INFO - Downloading docopt-0.6.1.tar.gz 09:31:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:31:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:31:21 INFO - Installing collected packages: blobuploader, requests, docopt 09:31:21 INFO - Running setup.py install for blobuploader 09:31:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:31:21 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:31:21 INFO - Running setup.py install for requests 09:31:22 INFO - Running setup.py install for docopt 09:31:22 INFO - Successfully installed blobuploader requests docopt 09:31:22 INFO - Cleaning up... 09:31:22 INFO - Return code: 0 09:31:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:22 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 0x7f02c0adfc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aaf7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af3d70>, '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 0x1af4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af4fb0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1448040511.715958-1160632041', '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 09:31:22 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 09:31:22 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 09:31:22 INFO - Using env: {'DISPLAY': ':0', 09:31:22 INFO - 'HOME': '/home/cltbld', 09:31:22 INFO - 'LANG': 'en_US.UTF-8', 09:31:22 INFO - 'LANGUAGE': 'en_US:en', 09:31:22 INFO - 'LOGNAME': 'cltbld', 09:31:22 INFO - 'MAIL': '/var/mail/cltbld', 09:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:22 INFO - 'MOZ_NO_REMOTE': '1', 09:31:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:22 INFO - 'NO_EM_RESTART': '1', 09:31:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:31:22 INFO - 'PWD': '/builds/slave/test-pgo', 09:31:22 INFO - 'SHELL': '/bin/bash', 09:31:22 INFO - 'SHLVL': '1', 09:31:22 INFO - 'TERM': 'linux', 09:31:22 INFO - 'TMOUT': '86400', 09:31:22 INFO - 'USER': 'cltbld', 09:31:22 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448040511.715958-1160632041', 09:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:22 INFO - '_': '/tools/buildbot/bin/python'} 09:31:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:31:22 INFO - Running setup.py (path:/tmp/pip-J8uBp8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:31:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:31:22 INFO - Running setup.py (path:/tmp/pip-39WDgR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:31:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:31:22 INFO - Running setup.py (path:/tmp/pip-8C5oDV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:31:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:31:22 INFO - Running setup.py (path:/tmp/pip-myQdWZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:31:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:31:22 INFO - Running setup.py (path:/tmp/pip-uRtAND-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:31:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:31:22 INFO - Running setup.py (path:/tmp/pip-62Su8A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:31:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:31:23 INFO - Running setup.py (path:/tmp/pip-Xhx6Hm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:31:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:31:23 INFO - Running setup.py (path:/tmp/pip-dUfdaj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:31:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:31:23 INFO - Running setup.py (path:/tmp/pip-Jzjkez-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:31:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:31:23 INFO - Running setup.py (path:/tmp/pip-idQUNG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:31:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:31:23 INFO - Running setup.py (path:/tmp/pip-o7oAIj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:31:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:31:23 INFO - Running setup.py (path:/tmp/pip-g9DjDf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:31:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:31:23 INFO - Running setup.py (path:/tmp/pip-JFFn7N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:31:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:31:23 INFO - Running setup.py (path:/tmp/pip-On0q3X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:31:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:31:23 INFO - Running setup.py (path:/tmp/pip-Pb9Vmi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:31:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:31:23 INFO - Running setup.py (path:/tmp/pip-JUJDwM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:31:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:31:23 INFO - Running setup.py (path:/tmp/pip-IDJeZN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:31:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:31:23 INFO - Running setup.py install for manifestparser 09:31:23 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:31:23 INFO - Running setup.py install for mozcrash 09:31:24 INFO - Running setup.py install for mozdebug 09:31:24 INFO - Running setup.py install for mozdevice 09:31:24 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:31:24 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:31:24 INFO - Running setup.py install for mozfile 09:31:24 INFO - Running setup.py install for mozhttpd 09:31:24 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:31:24 INFO - Running setup.py install for mozinfo 09:31:24 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:31:24 INFO - Running setup.py install for mozInstall 09:31:24 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:31:24 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:31:24 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:31:24 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:31:24 INFO - Running setup.py install for mozleak 09:31:24 INFO - Running setup.py install for mozlog 09:31:24 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:31:24 INFO - Running setup.py install for moznetwork 09:31:24 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:31:24 INFO - Running setup.py install for mozprocess 09:31:25 INFO - Running setup.py install for mozprofile 09:31:25 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:31:25 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:31:25 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:31:25 INFO - Running setup.py install for mozrunner 09:31:25 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:31:25 INFO - Running setup.py install for mozscreenshot 09:31:25 INFO - Running setup.py install for moztest 09:31:25 INFO - Running setup.py install for mozversion 09:31:25 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:31:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:31:25 INFO - Cleaning up... 09:31:25 INFO - Return code: 0 09:31:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:31:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f02c0adfc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aaf7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af3d70>, '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 0x1af4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af4fb0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1448040511.715958-1160632041', '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 09:31:25 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 09:31:25 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 09:31:25 INFO - Using env: {'DISPLAY': ':0', 09:31:25 INFO - 'HOME': '/home/cltbld', 09:31:25 INFO - 'LANG': 'en_US.UTF-8', 09:31:25 INFO - 'LANGUAGE': 'en_US:en', 09:31:25 INFO - 'LOGNAME': 'cltbld', 09:31:25 INFO - 'MAIL': '/var/mail/cltbld', 09:31:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:25 INFO - 'MOZ_NO_REMOTE': '1', 09:31:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:25 INFO - 'NO_EM_RESTART': '1', 09:31:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:31:25 INFO - 'PWD': '/builds/slave/test-pgo', 09:31:25 INFO - 'SHELL': '/bin/bash', 09:31:25 INFO - 'SHLVL': '1', 09:31:25 INFO - 'TERM': 'linux', 09:31:25 INFO - 'TMOUT': '86400', 09:31:25 INFO - 'USER': 'cltbld', 09:31:25 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448040511.715958-1160632041', 09:31:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:25 INFO - '_': '/tools/buildbot/bin/python'} 09:31:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:31:25 INFO - Running setup.py (path:/tmp/pip-743tFc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:31:25 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)) 09:31:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:31:25 INFO - Running setup.py (path:/tmp/pip-k8JAJz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:31:25 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)) 09:31:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:31:25 INFO - Running setup.py (path:/tmp/pip-z1pRuh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:31:26 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)) 09:31:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:31:26 INFO - Running setup.py (path:/tmp/pip-b0k48W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:31:26 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)) 09:31:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:31:26 INFO - Running setup.py (path:/tmp/pip-A1Te8y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:31:26 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)) 09:31:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:31:26 INFO - Running setup.py (path:/tmp/pip-f0TZN_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:31:26 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)) 09:31:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:31:26 INFO - Running setup.py (path:/tmp/pip-nZKP6P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:31:26 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)) 09:31:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:31:26 INFO - Running setup.py (path:/tmp/pip-eq5B8f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:31:26 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)) 09:31:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:31:26 INFO - Running setup.py (path:/tmp/pip-rxFq7w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:31:26 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)) 09:31:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:31:26 INFO - Running setup.py (path:/tmp/pip-DgMF5X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:31:26 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)) 09:31:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:31:26 INFO - Running setup.py (path:/tmp/pip-E9eZQ1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:31:26 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)) 09:31:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:31:26 INFO - Running setup.py (path:/tmp/pip-M30Zvl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:31:26 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)) 09:31:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:31:26 INFO - Running setup.py (path:/tmp/pip-tK6Y_j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:31:26 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)) 09:31:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:31:26 INFO - Running setup.py (path:/tmp/pip-6eR7T9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:31:26 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)) 09:31:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:31:26 INFO - Running setup.py (path:/tmp/pip-61uLjN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:31:26 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)) 09:31:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:31:26 INFO - Running setup.py (path:/tmp/pip-4FJSUv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:31:26 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)) 09:31:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:31:26 INFO - Running setup.py (path:/tmp/pip-8DVegp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:31:27 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)) 09:31:27 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)) 09:31:27 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)) 09:31:27 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)) 09:31:27 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)) 09:31:27 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)) 09:31:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:31:27 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 09:31:27 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 09:31:27 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 09:31:27 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 09:31:27 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 09:31:27 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 09:31:28 INFO - Downloading blessings-1.5.1.tar.gz 09:31:28 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 09:31:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:31:28 INFO - Installing collected packages: blessings 09:31:28 INFO - Running setup.py install for blessings 09:31:28 INFO - Successfully installed blessings 09:31:28 INFO - Cleaning up... 09:31:28 INFO - Return code: 0 09:31:28 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:31:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:31:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:31:29 INFO - Reading from file tmpfile_stdout 09:31:29 INFO - Current package versions: 09:31:29 INFO - argparse == 1.2.1 09:31:29 INFO - blessings == 1.5.1 09:31:29 INFO - blobuploader == 1.2.4 09:31:29 INFO - docopt == 0.6.1 09:31:29 INFO - manifestparser == 1.1 09:31:29 INFO - mozInstall == 1.12 09:31:29 INFO - mozcrash == 0.16 09:31:29 INFO - mozdebug == 0.1 09:31:29 INFO - mozdevice == 0.47 09:31:29 INFO - mozfile == 1.2 09:31:29 INFO - mozhttpd == 0.7 09:31:29 INFO - mozinfo == 0.9 09:31:29 INFO - mozleak == 0.1 09:31:29 INFO - mozlog == 3.0 09:31:29 INFO - moznetwork == 0.27 09:31:29 INFO - mozprocess == 0.22 09:31:29 INFO - mozprofile == 0.27 09:31:29 INFO - mozrunner == 6.11 09:31:29 INFO - mozscreenshot == 0.1 09:31:29 INFO - mozsystemmonitor == 0.0 09:31:29 INFO - moztest == 0.7 09:31:29 INFO - mozversion == 1.4 09:31:29 INFO - psutil == 3.1.1 09:31:29 INFO - requests == 1.2.3 09:31:29 INFO - wsgiref == 0.1.2 09:31:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:31:29 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')]} 09:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:29 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')]} 09:31:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:29 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 0x7f02c0adfc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aaf7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af3d70>, '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 0x1af4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af4fb0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1448040511.715958-1160632041', '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 09:31:29 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 09:31:29 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 09:31:29 INFO - Using env: {'DISPLAY': ':0', 09:31:29 INFO - 'HOME': '/home/cltbld', 09:31:29 INFO - 'LANG': 'en_US.UTF-8', 09:31:29 INFO - 'LANGUAGE': 'en_US:en', 09:31:29 INFO - 'LOGNAME': 'cltbld', 09:31:29 INFO - 'MAIL': '/var/mail/cltbld', 09:31:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:29 INFO - 'MOZ_NO_REMOTE': '1', 09:31:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:29 INFO - 'NO_EM_RESTART': '1', 09:31:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:31:29 INFO - 'PWD': '/builds/slave/test-pgo', 09:31:29 INFO - 'SHELL': '/bin/bash', 09:31:29 INFO - 'SHLVL': '1', 09:31:29 INFO - 'TERM': 'linux', 09:31:29 INFO - 'TMOUT': '86400', 09:31:29 INFO - 'USER': 'cltbld', 09:31:29 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448040511.715958-1160632041', 09:31:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:29 INFO - '_': '/tools/buildbot/bin/python'} 09:31:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:29 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)) 09:31:29 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)) 09:31:29 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)) 09:31:29 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)) 09:31:29 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)) 09:31:29 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)) 09:31:29 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)) 09:31:29 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)) 09:31:29 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)) 09:31:29 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)) 09:31:29 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)) 09:31:29 INFO - Cleaning up... 09:31:29 INFO - Return code: 0 09:31:29 INFO - Running post-action listener: _resource_record_post_action 09:31:29 INFO - Running post-action listener: _start_resource_monitoring 09:31:29 INFO - Starting resource monitoring. 09:31:29 INFO - ##### 09:31:29 INFO - ##### Running install step. 09:31:29 INFO - ##### 09:31:29 INFO - Running pre-action listener: _resource_record_pre_action 09:31:29 INFO - Running main action method: install 09:31:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:31:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:31:29 INFO - Reading from file tmpfile_stdout 09:31:29 INFO - Detecting whether we're running mozinstall >=1.0... 09:31:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:31:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:31:29 INFO - Reading from file tmpfile_stdout 09:31:29 INFO - Output received: 09:31:29 INFO - Usage: mozinstall [options] installer 09:31:29 INFO - Options: 09:31:29 INFO - -h, --help show this help message and exit 09:31:29 INFO - -d DEST, --destination=DEST 09:31:29 INFO - Directory to install application into. [default: 09:31:29 INFO - "/builds/slave/test-pgo"] 09:31:29 INFO - --app=APP Application being installed. [default: firefox] 09:31:29 INFO - mkdir: /builds/slave/test-pgo/build/application 09:31:29 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'] 09:31:29 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 09:31:44 INFO - Reading from file tmpfile_stdout 09:31:44 INFO - Output received: 09:31:44 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:31:44 INFO - Running post-action listener: _resource_record_post_action 09:31:44 INFO - ##### 09:31:44 INFO - ##### Running run-tests step. 09:31:44 INFO - ##### 09:31:44 INFO - Running pre-action listener: _resource_record_pre_action 09:31:44 INFO - Running main action method: run_tests 09:31:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:31:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:31:44 INFO - Python 2.7.3 09:31:44 INFO - Return code: 0 09:31:44 INFO - grabbing minidump binary from tooltool 09:31:44 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')]} 09:31:44 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 0x1af3d70>, '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 0x1af4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af4fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:31:44 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 09:31:44 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 09:31:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:31:44 INFO - Return code: 0 09:31:44 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:31:44 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:31:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:31:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:31:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:31:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/tBW8e_9rRTyfx6v-MFAxoA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 09:31:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/tBW8e_9rRTyfx6v-MFAxoA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost 09:31:44 INFO - Using env: {'DISPLAY': ':0', 09:31:44 INFO - 'HOME': '/home/cltbld', 09:31:44 INFO - 'LANG': 'en_US.UTF-8', 09:31:44 INFO - 'LANGUAGE': 'en_US:en', 09:31:44 INFO - 'LOGNAME': 'cltbld', 09:31:44 INFO - 'MAIL': '/var/mail/cltbld', 09:31:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:31:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:31:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:44 INFO - 'MOZ_NO_REMOTE': '1', 09:31:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:31:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:44 INFO - 'NO_EM_RESTART': '1', 09:31:44 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:31:44 INFO - 'PWD': '/builds/slave/test-pgo', 09:31:44 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:31:44 INFO - 'SHELL': '/bin/bash', 09:31:44 INFO - 'SHLVL': '1', 09:31:44 INFO - 'TERM': 'linux', 09:31:44 INFO - 'TMOUT': '86400', 09:31:44 INFO - 'USER': 'cltbld', 09:31:44 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448040511.715958-1160632041', 09:31:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:44 INFO - '_': '/tools/buildbot/bin/python'} 09:31:44 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/tBW8e_9rRTyfx6v-MFAxoA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost'] with output_timeout 3600 09:31:44 INFO - mozversion INFO | application_buildid: 20151120073302 09:31:44 INFO - mozversion INFO | application_changeset: 14bd25c639127766d0c29c651e764fe53a3144a2 09:31:44 INFO - mozversion INFO | application_display_name: Nightly 09:31:44 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:31:44 INFO - mozversion INFO | application_name: Firefox 09:31:44 INFO - mozversion INFO | application_remotingname: firefox 09:31:44 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:31:44 INFO - mozversion INFO | application_vendor: Mozilla 09:31:44 INFO - mozversion INFO | application_version: 45.0a1 09:31:44 INFO - mozversion INFO | platform_buildid: 20151120073302 09:31:44 INFO - mozversion INFO | platform_changeset: 14bd25c639127766d0c29c651e764fe53a3144a2 09:31:44 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:31:44 INFO - mozversion INFO | platform_version: 45.0a1 09:31:44 INFO - 2015-11-20 09:31:44,417 DEBUG : using testdate: 1448040704 09:31:44 INFO - 2015-11-20 09:31:44,417 DEBUG : actual date: 1448040704 09:31:44 INFO - 2015-11-20 09:31:44,468 INFO : starting webserver on 'localhost:34584' 09:31:44 INFO - 2015-11-20 09:31:44,469 INFO : Starting test suite talos-linux64-ix-004.e 09:31:44 INFO - 2015-11-20 09:31:44,469 INFO : Starting test dromaeo_css 09:31:44 INFO - 2015-11-20 09:31:44,469 DEBUG : operating with platform_type : linux_ 09:31:44 INFO - 2015-11-20 09:31:44,470 INFO : Initialising browser for dromaeo_css test... 09:31:44 INFO - 2015-11-20 09:31:44,479 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKSZCly/profile http://localhost:34584/getInfo.html 09:31:51 INFO - 2015-11-20 09:31:51,025 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:31:51 INFO - 2015-11-20 09:31:51,025 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:31:51 INFO - 2015-11-20 09:31:51,025 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:31:51 INFO - 2015-11-20 09:31:51,025 DEBUG : BROWSER_OUTPUT: __metrics 09:31:52 INFO - 2015-11-20 09:31:52,163 INFO : Browser initialized. 09:31:52 INFO - 2015-11-20 09:31:52,164 INFO : Running cycle 1/1 for dromaeo_css test... 09:31:52 INFO - 2015-11-20 09:31:52,164 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKSZCly/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:32:04 INFO - 2015-11-20 09:32:04,012 DEBUG : BROWSER_OUTPUT: RSS: Main: 141762560 09:32:04 INFO - 2015-11-20 09:32:04,012 DEBUG : BROWSER_OUTPUT: 09:32:53 INFO - 2015-11-20 09:32:53,650 DEBUG : BROWSER_OUTPUT: 1448040773645 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] 09:35:02 INFO - 2015-11-20 09:35:02,678 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34584/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34584/tests/dromaeo/cssquery-ext.html) 09:35:03 INFO - 2015-11-20 09:35:03,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 146886656 09:35:03 INFO - 2015-11-20 09:35:03,828 DEBUG : BROWSER_OUTPUT: 09:38:05 INFO - 2015-11-20 09:38:05,861 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34584/tests/dromaeo/cssquery-ext.html (next: http://localhost:34584/tests/dromaeo/cssquery-jquery.html) 09:38:06 INFO - 2015-11-20 09:38:06,442 DEBUG : BROWSER_OUTPUT: RSS: Main: 140627968 09:38:06 INFO - 2015-11-20 09:38:06,442 DEBUG : BROWSER_OUTPUT: 09:41:08 INFO - 2015-11-20 09:41:08,121 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34584/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34584/tests/dromaeo/cssquery-mootools.html) 09:41:08 INFO - 2015-11-20 09:41:08,710 DEBUG : BROWSER_OUTPUT: RSS: Main: 142233600 09:41:08 INFO - 2015-11-20 09:41:08,711 DEBUG : BROWSER_OUTPUT: 09:44:10 INFO - 2015-11-20 09:44:10,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34584/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34584/tests/dromaeo/cssquery-prototype.html) 09:44:10 INFO - 2015-11-20 09:44:10,965 DEBUG : BROWSER_OUTPUT: RSS: Main: 139800576 09:44:10 INFO - 2015-11-20 09:44:10,965 DEBUG : BROWSER_OUTPUT: 09:47:13 INFO - 2015-11-20 09:47:13,270 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34584/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34584/tests/dromaeo/cssquery-yui.html) 09:47:13 INFO - 2015-11-20 09:47:13,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 141737984 09:47:13 INFO - 2015-11-20 09:47:13,856 DEBUG : BROWSER_OUTPUT: 09:50:16 INFO - 2015-11-20 09:50:16,056 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34584/tests/dromaeo/cssquery-yui.html (next: http://localhost:34584/tests/dromaeo/cssquery-dojo.html) 09:50:16 INFO - 2015-11-20 09:50:16,306 DEBUG : BROWSER_OUTPUT: RSS: Main: 144154624 09:50:16 INFO - 2015-11-20 09:50:16,306 DEBUG : BROWSER_OUTPUT: 09:50:16 INFO - 2015-11-20 09:50:16,306 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:50:16 INFO - 2015-11-20 09:50:16,306 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:50:16 INFO - 2015-11-20 09:50:16,307 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:50:16 INFO - 2015-11-20 09:50:16,307 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:50:16 INFO - 2015-11-20 09:50:16,308 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3223.3231021485485;3255.886043988461;3290.7696461247724;3308.421026320394;3324.052644996175;5189.662671926322;5403.972980135099;5433.782648694052;5452.672839629625;5463.562914966803;5386.91919621205;5405.243265942761;5444.863878403032;5535.557155427567;5540.778368865241;4934.802607895689;4993.975030124862;5030.6981581105065;5051.7726702298305;5053.519915608012;4905;4981.103401387749;4981.1335723246175;5036.7733451994745;5086.898262034757;4766.523347665206;4883.438404583483;4916.164252077119;5020.372453443338;5036.597072234213;4896.290037944478;4979.929315197213;4988.501149885019;4993.950060499421;5009.749512524396;4927.1870141426625;4953.306537084811;4955.430125535538;4968.87577810554;4969.950300496985;5121.590272778169;5201.765920533585;5248.895022099537;5260.351520648209;5284.815031473919;5744.195812586241;5866.413358664142;5941.524678025791;5947.316058653267;5992.041273396279;5828.329742079631;5883.558733094992;5891.911621325684;5940.435658612425;6006.609570377911;5364.785408583691;5510.421405752419;5520.723963801834;5523.226748255248;5531.668099914018;5792.88414231713;5907.4683278505145;5965.373635768182;5970.940290597126;5991.981363168272;5731.856703582361;5740.454656807597;5750.281214848144;5760.654360738369;5833.387494313036;5805.8548536286935;5813.593048486566;5860.882782344329;5920.851978700481;5923.881522369528;5776.480116789509;5838.708064596838;5849.88300233993;5854.912176317359;5872.706364681749;5839.328477225174;5844.444777746107;5921.822345329647;5922.703864806743;5932.199153114274;4414.492333381638;4477.932831007537;4487.326900964881;4534.183846907522;4573.222552166139;3947.5657677655436;4029.0934539728914;4045.0898547826505;4045.7977101144825;4065.5527891931865;5606.579506536945;5620.044592419298;5630.436956304418;5634.7182640867795;5642.238297829823;5733.799317023884;5872.354041055481;5936.257967754031;5941.22764040672;5941.70291485424;5501.807436739775;5572.554195664337;5581.720913954286;5585.525230355384;5646.85882852932;5106.565941894906;5147.845564633067;5166.769181928234;5170.121079416508;5207.609429292818;5881.911771323434;5941.168236446901;5995.400459954057;6090.908636370458;6112.205413296243;5936.5844390892225;5970.641761494324;5979.461848433488;6000.759969601341;6019.18740969981;6093.847653808513;6098.634081955097;6102.786402475892;6112;6124.173236613;5645.294338207724;5703;5737.08206686928;5898.498627616701;5898.557608179318;5860.120981852756;5867.442592953663;5872.148538461985;5876.294844618673;5959.255093113361;5658.971705141448;5694.772209111589;5696.088625819849;5697.373288938131;5700.315962084576;5552.305961754781;5623.606347555632;5663.830085097454;5687.43125687428;5788.334341550607;5584.553235741212;5617.915731264116;5630.60585758993;5635.520980716685;5653.038983372754;5732.16883551891;5734.799282025109;5767.163761254678;5783.363829978614;5791.82624521265;5484.506394424361;5568.192612071308;5626.32484101894;5707.7716891325545;5778.797742079007 09:50:16 INFO - 2015-11-20 09:50:16,309 DEBUG : BROWSER_OUTPUT: |1;ext.html;584.8157830283461;588.9676067816271;591.3347484080408;602.9517638588914;617.4813156948163;39573.80213098934;40005.39991900124;40209.79895100528;40283.59716402839;40433.59566404335;42667.146657066914;42932.78533607336;43166.13667726643;43278.13443731124;43288.35067473983;8727.258183054448;8825.073367296438;8862.645494180257;8871.733847984538;8886.511241881693;8579.356548258875;8593;8610.612522436506;8631.43895646781;8641.65433382664;8470.32237421008;8601.096884827097;8626.870596941051;8640.697575584856;8650.26472749817;8628.22345988864;8645.567721613925;8679.652813887436;8722.912770872304;8723.869141962876;8509.149085091503;8594.054653988056;8612;8650.178233067849;8650.65397384104;39964.800175999226;40391.7980410099;40523.7973810132;40556;40583.59416405857;3242.9946716517957;3312.453445181542;3626.38351480249;3909.1331292540685;3926.6466018058513;29738.702612974026;30771.230719231975;30772.846135769178;30842.69157308443;31586.36827263442;3925.8429662813455;4030.496187976503;4032.717709760318;4077.7145599808027;4160.625543701051;282537;284456;285217;286878;287050.564747177;51079.48920510747;61052.389476105556;61065.694671526355;61167.69416152891;61182.69408653017;49843.50156498388;71207;71440.28559714441;71588.64205678938;71659.64170179116;15840.60398490047;15959.122248276457;15967.60080997961;16022.919885400499;16049.759253611206;11842.348670823187;12121;12129.15095943293;12134.75730485403;12213;20171.697424538645;20262.594748104955;20336.186552538027;20457.48856278605;20540.5351357838;7947.205279472007;8123.512589244664;8158.2657560818625;8239.134890836376;8254.298384637254;1037.2894567221476;1037.419045334615;1058.9713419619882;1084.5228099636136;1104.4091411095026;28295.29261768472;28530.429391412057;28688.426231475252;28818.567721484196;29117.7088229115;1043.3479075577764;1065.4033741105006;1072.9302595331435;1073.656429942411;1084.3277168155794;14831.703365932837;14925.92537037308;14963.40146394132;15052.397904083933;15230.543083707507;297606;297893;299427;300207;302038;51927;51964.48035519672;52163.73918130385;52402.47597523976;52411.59324643886;1331.4075236519657;1355.1733442600007;1365.4060483689627;1367.1045465220298;1372.1904076594858;27243.727562724118;28537.714622854335;28550.57174142431;28610.713892860804;28849.42301154007;46959.765201173774;47247.52752472431;47318.29022564596;47426.52573474221;47480;280877;282441;282535;282977;283055;32995.83502082474;45305.773471133754;45539.54460455485;45875.08249834918;46675.032622226136;44023.339649905916;44034.33948490711;44707.776461117486;44882.55117448914;45283.320750189436;36480.27039459249;36529.26941461103;36551.45172822357;37989;38160;36221.63778362288;36986.8150659245;37434.43848342223;37585.43621845729;37719.24561508809;36164.819175903955;36777.81611091927;37212.627873720914;37259.254814903004;37271.44092838556;32814.83592582022;33445.49831752477;34162.82918585391;34203.31593368168;36595.451068233466;25530.328264122734;25630;25790.13026774209;25921.870390647928;25971.740282596933 09:50:16 INFO - 2015-11-20 09:50:16,309 DEBUG : BROWSER_OUTPUT: |2;jquery.html;354.675471943172;355.10867722017736;356.81445648262905;357.17136243914115;359.1541918781268;16501.999999999985;17303.134843257834;17468.65062698745;18237.36169234077;18348.449546513624;16194.676106477864;16432.17839108043;16582.66834663309;16639.084850333256;17064.744028839577;4616.538346165382;4703.576678098971;4716.1982462981205;4743.478217396084;4756.334113224151;4652.255639097745;4721.952780472186;4775.212090005145;4778.2115950868065;4800.447948485917;4775.188218002948;4787.234042553192;4837.830675926343;4977.47736487669;4985.077760614298;4974.577160941324;5014.348134742497;5022.146235140035;5024.623153263502;5032.270320803481;5186.273921650972;5210.843674689765;5235.842924712227;5236.371635403738;5242.872782351813;11140.554377824958;11255.155863310203;13645.590632281048;18622.16200270991;18703.251869925185;2042.3668662714606;2068.327793467129;2091.7699053104147;2120.7349081364828;2124.2883633982633;8959.910400895973;9186.678466253716;11965.46155423008;12115.575954841626;12856.707728105683;1817.7727784026997;1819.3268490658409;1830.8901465912088;1847.2980267498265;1850.1119462658;56738.71630641862;59018;59376.70311648414;59575.40424595742;60021;9865.112139907444;9875.111239988435;9886.060824221688;9897.416413373825;9915.851262231072;12651;12679;12679.873201267868;12683.175593586388;12720.6819829505;7057.047298614724;7638.121616014118;7661;7667.731629393056;7695.730649427243;7375.668094935741;7385.741499047507;7389.630518474055;7404.96297518509;7447.664855081534;3941.2117576484816;4065.593440655911;4121.9381709274385;4192.140611174702;4268.359746038057;1663.717168081429;1665.5669525923347;1684.0400971446402;1770.69012922738;1770.9203085860909;374.83881930769485;376.63842710997204;379.4876916163213;382.0753775862364;394.51080659981415;9593.088656577615;10198.18414526836;10419.114375278035;10451.790964180675;10728.141748660088;367.4231456613092;914.9588268527932;927.5733162745078;931.4737173496952;950.4012472142506;5568.276124103841;5570;5740.54075673945;9049.547522623843;9542.236621070298;531223;535329;552647;566992;576569;80251.19748802554;83914;84386;84621;85207;432.28456903824224;434.87171284471157;438.38625923707065;438.72141190343723;442.3166208208326;9726.319157658896;9777;9859.753506162404;10058.849117263393;10272.280940334404;36758.63241367552;37004.25991480209;37269;37794.8110259458;39016;47503.287450687574;48238.27642585434;48251.75874120607;48509;48509.5149048505;9111.908880911105;9322.254219662274;9816.460094694861;9836.311458197857;9850.310478266452;16660.50018499447;17062.317507300064;17087.31650733957;17407.56481087983;17419.39032133869;13426.597202083953;14179.078359906573;14271.928640357148;14339.354729037426;14908.850911490747;13692.794608080687;13739.106958047694;13826.239556824472;14186.858131418554;14443.422263109358;13975.301234938415;14196.432142714175;14305.642358940693;14487.275636218357;14664.780028299798;8567.571621419029;8645.394822362627;8669.003064647393;8693.478391296543;8733.694320698745;9343.205827504738;9365.765855853659;9485.288603354638;13580.25308608036;14129.293535322988 09:50:16 INFO - 2015-11-20 09:50:16,311 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1475.667974705691;1510.886683498738;1617.90292582445;1654.8014238291407;1771.291483406638;7017.228104908469;7169.318914703108;7601.429892758045;7757.883631745522;7775;7636.656350464228;7691.461597688164;7754.844903101949;7782.299593036626;7802.180771019032;1982.415187519685;2026;2029.2390353617393;2035.7557093148844;2041;2217.1796435318956;2234.229190929127;2238.944026399337;2256.4246117240164;2261.1407665087245;1915.7509523761962;1964.5776158126;2143.614149453098;2163.0482587661377;2168;2092.905819238138;2139.529303553216;2139.914403423869;2140.871547707143;2141.65733482642;2134.4557137929883;2148.4736239621393;2209.8674079555276;2211.237123192496;2212.6349152389835;7467.9626601867185;7534.510256833289;7542.35889949355;7565.43259255558;7573.772786816405;4407.647388208936;4442.311441726538;4493.820247190109;4505.977470112662;4521.050579378334;2948.9557656635166;2988.5517172424093;2989.2676294307817;3030.575719399286;3089.413011527825;989.569537251298;1039.3140527252053;1040.708601591548;1816.6548355812486;1864.794872564017;10127.746806329827;10328.173746100369;10340.948295258475;10386.428746418944;10413.843792343197;3870.283997460479;3882.592327805596;3912.491376121086;3939.094008378032;3986.421968814506;8285.95857020723;8352.958235208785;8356.70751523706;8366.330693544502;8418.242358187792;4495.280755079171;4504.414426124583;4507.2788353863225;4510.954890451054;4526.547345265513;4161.687873409506;4174.645155161785;4202.831886724558;4204.348326009474;4214.136102099063;3391.2369716814014;3393.185635447475;3412.505186747908;3426.0578340956436;3426.229098452828;1051.4795176387738;1064.984025239622;1067.8985496377832;1069.1072954083427;1073.1468482556386;1035.570238351091;1044.5038606661774;1045.639254457211;1289.8194252804615;1317.7891537353978;6886.655667216719;6998.125234345707;6999.23008469068;7025.332593403618;7141.607211603412;1124.1793490751797;1139.800534906388;1143.6111722014555;1150.715829079277;1151.6775302915198;5698.259226300637;5700.287464066992;5713.628614140068;5723.284589426322;5740.741666625012;8779.03430622631;8902.821943561092;8992.46045237288;9046.231070358961;9151.405158664666;8846.911530884738;8931.598078086501;8958.372913895964;8965;8977.50623715689;6690.13028306317;6782.559133656297;6848.520603557703;6957.826054348682;7048.400885924651;6757.459403247827;6848.657567121723;6851.3491218334175;6877.931220687929;6880.58716477013;7765.495242809199;7880.448368614142;7913.564753938589;7922.0889597697005;7942.404319675932;7938.880916786368;8113.229243221885;8113.5131892086665;8153.306968907472;8165.061017983008;7105.147382314155;7126.608036558039;7185.209626940928;7296.4162866969455;7337.0828646419195;7396.704131834666;7405.185429602631;7450.180480147071;7475.514091584029;7475.738349157971;6833.6674348501565;6944.444444444332;6974.4769142315545;7094.858102838018;7157.463190260647;6477.578957367756;6776.15298087739;6801.455883529206;6864;6957;6691.063251144747;6729.394354507922;6745.561538499982;6753.189617245962;6764.729410823709;5857.384974577608;5890.911636325544;6020.036794112921;6047.213862198062;6072.514198863992;6291.748330066929;6335.524835637253;6379.2344918608205;6380.872382552416;6402 09:50:16 INFO - 2015-11-20 09:50:16,312 DEBUG : BROWSER_OUTPUT: |4;prototype.html;307.4573377987851;310.45360166107656;315.2544232889216;316.446219116546;322.36654972978096;6272.874542509153;6390.424861762441;6447.2263328400595;6492.026196070586;6578.309277525863;6298.244210694712;6326.304106548276;6355.332690067546;6364.204474440695;6367.331430199832;4751.40607424072;4754.072955773626;4760.7619619019;4762.738049407281;4775.474697783241;4704.45898721648;4734.502877197879;4735.786889589976;4738.502457241992;4777.235642297233;4615.399998000272;4703.459102203256;4704.059188162364;4720.59874910633;4729.50340214276;4705.929411058837;4708.882277943045;4713.882152946187;4720.929186062212;4730.503297153784;4049.453323801308;4050.736702114353;4051.1290072634524;4054.736442131252;4058.391241313797;6058.939410605882;6062.514998800086;6062.9090563641585;6064;6064.3935606439445;5366;5469.535089517396;5472.972635136839;5474.479924407215;5495.780168793243;6694.899576506356;6716.294789047129;6717.731290748364;6719.496037797136;6728.562643428161;4450.755208463534;4454.020115574568;4454.933176002362;4459.843905463325;4460.6208472279895;6843.247242803288;6912.308769123098;7004;7005.894911576331;7017.333353331476;4513.458384993756;4515.503294637587;4519.344695019269;4527.253003254426;4540.228161212602;4581.702189357681;4582.747948862778;4592.2193227151465;4604.37840891482;4611.654125940568;5433.320834895638;5436.429174936575;5437.891242175214;5441.972790136103;5445.83662490126;6635.966820165965;6805.863882722318;6811.897821532681;6812.386885180357;6839.384455398938;1557.6573153906122;1599.6720672262159;1624.0499307905009;1628.0638632786195;1630.5026966775247;1017.4658304390255;1048.5858086055964;1063.787282497953;1066.5520481397832;1072.4905669806935;6393.104965304861;6429.32492088324;6438.323975982548;6446.645434501053;6447.516436267205;6878.7248510060035;6884.139482564679;6898.275681053417;6902.654867256617;6916.930830691729;6379.617222966637;6428.19647544057;6430.485561155097;6437.774677886251;6438.098666186737;3796.962030379716;3833.7124715646437;3836.366999445116;3837.3860182370686;3841.0589405595806;7352.411807055422;7356.521826081287;7358.963205184047;7364;7370.815729606696;7084.645767711697;7255.709771609077;7264.636768161571;7275.745348912763;7296.96351518239;7144.285571442918;7151.928480715231;7169.713211471482;7189.92810071903;7326.670299836626;7004.439644828503;7021.43828493709;7044.084269045196;7051.048108505286;7057.2237053923;6806.285340039224;6967.407770339578;6979.616121113185;7000.194977577644;7010.404115650227;7319.231480694663;7379.926200737924;7386.926130738624;7393;7398.445116616383;4517.09658068381;4572;4585.656075794262;4589.196890544074;4598.034412773221;6824.454043676593;6856.691448884912;7012.964935175291;7058.6470676467;7106.040684507525;6703.262641109572;6817.659117044029;6836.077129587442;6856.9314306856295;6872.69072891711;6859.142607174103;6860.348266914635;6861.210960739579;6862.759803406857;6865.382115609619;6603.273639899703;6679.699413526306;6723.226828914738;6728.394444499822;6738.629375384401;6891.517593768388;6894.24163342042;6908.585484870924;6909.378155965987;6911.481638877004;6658.866822663423;6663.067170596218;6721.193456785217;6737.023131645982;6742.494312926452 09:50:16 INFO - 2015-11-20 09:50:16,312 DEBUG : BROWSER_OUTPUT: |5;yui.html;755.4183278875266;790.9762707118789;829.5022986208272;832.8875601793756;871.0505548951644;11979.580714674978;12177.452014659339;12203.57287494938;12214.083943704214;12234.632961011162;12174.81737773934;13056.804147937788;13136.6715832104;13175.868241317585;13208.537701180461;779.2558107007794;783.1972228465811;799.9960000199991;802.3701394405393;811.4968719393984;811.8213992921548;811.979700507489;812.3907069697726;814.2346194577108;816.0330008939396;616.2974209401286;616.4298024327502;617.3363634093345;618.2395653346364;621.4779585148474;614.984625384369;616.0758861707438;616.4513582911212;616.7625464196271;618.7308520793447;447.1437197766274;448.93714879916837;450.3065279469613;450.6957803482669;454.1779379323435;12379.381030948416;12408.56570020054;12420.875791242062;12464;12495.437705303193;11354.43227838613;11422.771544569145;11796.410179491077;11900.821487677691;12491.063170262267;9758.487434447672;9794.608215671436;9978.750531236705;10089.445080520569;10240.129588984944;3575.2134530403528;3598.24436868258;3607.134287770942;3607.278544291126;3607.5851277103206;49242.753786231195;49354.259686104735;49432.25851612229;49466.25800612994;50105.49894501081;9510.38182518134;9764.072413120743;9790.314677972474;9906.306558540833;9917.950410247902;17628.735568966476;17748.733768993476;17843.553911152325;17914.91042544805;17942.102894855205;7081.185663648644;7125.964370178116;7169.211386747454;7378.225286344857;7445.739399121005;4006.979965100156;4091.85678501251;4095.508538975342;4098.446709694213;4128.731632443882;3076.4308602908086;3103.2707313781243;3108.2074071112174;3115.7195852373397;3120.953185702216;509.28191250336846;541.4855886907375;549.815811703076;570.9800156994485;571.0235497299581;585.6690969602162;595.169738215196;618.2364779497317;618.4557589321458;669.2270427656065;8024.79938001543;8196.795080123045;8273.863068465767;8351.415400921998;8748.912510874938;519.462356461061;537.6800803521899;587.7472686744741;649.6102338596804;678.6538865178794;3740.663340299386;3834.7123965702685;3916.58875818035;3921.9607803921594;3976.721629485908;53680;60698.69650651807;60913;61025;61878;50881.49118508842;51633;51652.22521662103;52282.215766763526;52651.210231846555;45271.77364113224;45338;45876.311855322194;47926.5207347929;48338.27492587614;8107.675692972215;8115.59422028908;8138.511689298661;8260.710875119583;8427.544706670236;31989.36021279608;32662;33849.830750846086;35566;36091.81954090213;40980.3852942212;41217;42058;44172.779136104116;45219.32171017372;10309.175265978554;10487.685369438928;10976.341419514854;11067.114630829354;11324.66553608456;11797.469113889723;11963;11987.34069626179;12004.519819207135;12017.879821201675;10294.536745846304;10372.484573042348;10499.68500944973;10551;10620.89379106199;11385.772284554097;11436.085113190758;11608.593699220486;11720.179587428798;12285.385730713608;10491.895081049091;10592.311499752492;10788.568457261621;10963.068139208257;10968.725781855199;9686;9717.611295548098;9937.602495900372;9948.602055917681;10401.53193106297;8477.23704866565;8549.187827156411;8649.524276164871;8732.65069397217;8963.372563920462 09:50:16 INFO - 2015-11-20 09:50:16,312 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:50:16 INFO - 2015-11-20 09:50:16,312 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:50:16 INFO - 2015-11-20 09:50:16,312 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,291 09:50:16 INFO - 2015-11-20 09:50:16,312 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:50:16 INFO - 2015-11-20 09:50:16,312 DEBUG : BROWSER_OUTPUT: __startTimestamp1448041816305__endTimestamp 09:50:16 INFO - 2015-11-20 09:50:16,312 DEBUG : BROWSER_OUTPUT: 09:50:16 INFO - 2015-11-20 09:50:16,312 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:50:16 INFO - 2015-11-20 09:50:16,312 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:50:16 INFO - 2015-11-20 09:50:16,313 DEBUG : BROWSER_OUTPUT: 09:50:16 INFO - 2015-11-20 09:50:16,313 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5445.57 Median:5642.24 stddev:607.74 (10.8%) stddev-sans-first:584.07 09:50:16 INFO - 2015-11-20 09:50:16,313 DEBUG : BROWSER_OUTPUT: Values: 3223.3 3255.9 3290.8 3308.4 3324.1 5189.7 5404.0 5433.8 5452.7 5463.6 5386.9 5405.2 5444.9 5535.6 5540.8 4934.8 4994.0 5030.7 5051.8 5053.5 4905.0 4981.1 4981.1 5036.8 5086.9 4766.5 4883.4 4916.2 5020.4 5036.6 4896.3 4979.9 4988.5 4994.0 5009.7 4927.2 4953.3 4955.4 4968.9 4970.0 5121.6 5201.8 5248.9 5260.4 5284.8 5744.2 5866.4 5941.5 5947.3 5992.0 5828.3 5883.6 5891.9 5940.4 6006.6 5364.8 5510.4 5520.7 5523.2 5531.7 5792.9 5907.5 5965.4 5970.9 5992.0 5731.9 5740.5 5750.3 5760.7 5833.4 5805.9 5813.6 5860.9 5920.9 5923.9 5776.5 5838.7 5849.9 5854.9 5872.7 5839.3 5844.4 5921.8 5922.7 5932.2 4414.5 4477.9 4487.3 4534.2 4573.2 3947.6 4029.1 4045.1 4045.8 4065.6 5606.6 5620.0 5630.4 5634.7 5642.2 5733.8 5872.4 5936.3 5941.2 5941.7 5501.8 5572.6 5581.7 5585.5 5646.9 5106.6 5147.8 5166.8 5170.1 5207.6 5881.9 5941.2 5995.4 6090.9 6112.2 5936.6 5970.6 5979.5 6000.8 6019.2 6093.8 6098.6 6102.8 6112.0 6124.2 5645.3 5703.0 5737.1 5898.5 5898.6 5860.1 5867.4 5872.1 5876.3 5959.3 5659.0 5694.8 5696.1 5697.4 5700.3 5552.3 5623.6 5663.8 5687.4 5788.3 5584.6 5617.9 5630.6 5635.5 5653.0 5732.2 5734.8 5767.2 5783.4 5791.8 5484.5 5568.2 5626.3 5707.8 5778.8 09:50:16 INFO - 2015-11-20 09:50:16,313 DEBUG : BROWSER_OUTPUT: 09:50:16 INFO - 2015-11-20 09:50:16,314 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46941.24 Median:37652.34 stddev:75399.18 (200.3%) stddev-sans-first:75530.35 09:50:16 INFO - 2015-11-20 09:50:16,314 DEBUG : BROWSER_OUTPUT: Values: 584.8 589.0 591.3 603.0 617.5 39573.8 40005.4 40209.8 40283.6 40433.6 42667.1 42932.8 43166.1 43278.1 43288.4 8727.3 8825.1 8862.6 8871.7 8886.5 8579.4 8593.0 8610.6 8631.4 8641.7 8470.3 8601.1 8626.9 8640.7 8650.3 8628.2 8645.6 8679.7 8722.9 8723.9 8509.1 8594.1 8612.0 8650.2 8650.7 39964.8 40391.8 40523.8 40556.0 40583.6 3243.0 3312.5 3626.4 3909.1 3926.6 29738.7 30771.2 30772.8 30842.7 31586.4 3925.8 4030.5 4032.7 4077.7 4160.6 282537.0 284456.0 285217.0 286878.0 287050.6 51079.5 61052.4 61065.7 61167.7 61182.7 49843.5 71207.0 71440.3 71588.6 71659.6 15840.6 15959.1 15967.6 16022.9 16049.8 11842.3 12121.0 12129.2 12134.8 12213.0 20171.7 20262.6 20336.2 20457.5 20540.5 7947.2 8123.5 8158.3 8239.1 8254.3 1037.3 1037.4 1059.0 1084.5 1104.4 28295.3 28530.4 28688.4 28818.6 29117.7 1043.3 1065.4 1072.9 1073.7 1084.3 14831.7 14925.9 14963.4 15052.4 15230.5 297606.0 297893.0 299427.0 300207.0 302038.0 51927.0 51964.5 52163.7 52402.5 52411.6 1331.4 1355.2 1365.4 1367.1 1372.2 27243.7 28537.7 28550.6 28610.7 28849.4 46959.8 47247.5 47318.3 47426.5 47480.0 280877.0 282441.0 282535.0 282977.0 283055.0 32995.8 45305.8 45539.5 45875.1 46675.0 44023.3 44034.3 44707.8 44882.6 45283.3 36480.3 36529.3 36551.5 37989.0 38160.0 36221.6 36986.8 37434.4 37585.4 37719.2 36164.8 36777.8 37212.6 37259.3 37271.4 32814.8 33445.5 34162.8 34203.3 36595.5 25530.3 25630.0 25790.1 25921.9 25971.7 09:50:16 INFO - 2015-11-20 09:50:16,314 DEBUG : BROWSER_OUTPUT: 09:50:16 INFO - 2015-11-20 09:50:16,314 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28639.13 Median:440.52 stddev:90500.94 (20544.2%) stddev-sans-first:90729.90 09:50:16 INFO - 2015-11-20 09:50:16,316 DEBUG : BROWSER_OUTPUT: Values: 354.7 355.1 356.8 357.2 359.2 16502.0 17303.1 17468.7 18237.4 18348.4 16194.7 16432.2 16582.7 16639.1 17064.7 4616.5 4703.6 4716.2 4743.5 4756.3 4652.3 4722.0 4775.2 4778.2 4800.4 4775.2 4787.2 4837.8 4977.5 4985.1 4974.6 5014.3 5022.1 5024.6 5032.3 5186.3 5210.8 5235.8 5236.4 5242.9 11140.6 11255.2 13645.6 18622.2 18703.3 2042.4 2068.3 2091.8 2120.7 2124.3 8959.9 9186.7 11965.5 12115.6 12856.7 1817.8 1819.3 1830.9 1847.3 1850.1 56738.7 59018.0 59376.7 59575.4 60021.0 9865.1 9875.1 9886.1 9897.4 9915.9 12651.0 12679.0 12679.9 12683.2 12720.7 7057.0 7638.1 7661.0 7667.7 7695.7 7375.7 7385.7 7389.6 7405.0 7447.7 3941.2 4065.6 4121.9 4192.1 4268.4 1663.7 1665.6 1684.0 1770.7 1770.9 374.8 376.6 379.5 382.1 394.5 9593.1 10198.2 10419.1 10451.8 10728.1 367.4 915.0 927.6 931.5 950.4 5568.3 5570.0 5740.5 9049.5 9542.2 531223.0 535329.0 552647.0 566992.0 576569.0 80251.2 83914.0 84386.0 84621.0 85207.0 432.3 434.9 438.4 438.7 442.3 9726.3 9777.0 9859.8 10058.8 10272.3 36758.6 37004.3 37269.0 37794.8 39016.0 47503.3 48238.3 48251.8 48509.0 48509.5 9111.9 9322.3 9816.5 9836.3 9850.3 16660.5 17062.3 17087.3 17407.6 17419.4 13426.6 14179.1 14271.9 14339.4 14908.9 13692.8 13739.1 13826.2 14186.9 14443.4 13975.3 14196.4 14305.6 14487.3 14664.8 8567.6 8645.4 8669.0 8693.5 8733.7 9343.2 9365.8 9485.3 13580.3 14129.3 09:50:16 INFO - 2015-11-20 09:50:16,316 DEBUG : BROWSER_OUTPUT: 09:50:16 INFO - 2015-11-20 09:50:16,316 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5269.64 Median:5955.47 stddev:2704.75 (45.4%) stddev-sans-first:2697.31 09:50:16 INFO - 2015-11-20 09:50:16,316 DEBUG : BROWSER_OUTPUT: Values: 1475.7 1510.9 1617.9 1654.8 1771.3 7017.2 7169.3 7601.4 7757.9 7775.0 7636.7 7691.5 7754.8 7782.3 7802.2 1982.4 2026.0 2029.2 2035.8 2041.0 2217.2 2234.2 2238.9 2256.4 2261.1 1915.8 1964.6 2143.6 2163.0 2168.0 2092.9 2139.5 2139.9 2140.9 2141.7 2134.5 2148.5 2209.9 2211.2 2212.6 7468.0 7534.5 7542.4 7565.4 7573.8 4407.6 4442.3 4493.8 4506.0 4521.1 2949.0 2988.6 2989.3 3030.6 3089.4 989.6 1039.3 1040.7 1816.7 1864.8 10127.7 10328.2 10340.9 10386.4 10413.8 3870.3 3882.6 3912.5 3939.1 3986.4 8286.0 8353.0 8356.7 8366.3 8418.2 4495.3 4504.4 4507.3 4511.0 4526.5 4161.7 4174.6 4202.8 4204.3 4214.1 3391.2 3393.2 3412.5 3426.1 3426.2 1051.5 1065.0 1067.9 1069.1 1073.1 1035.6 1044.5 1045.6 1289.8 1317.8 6886.7 6998.1 6999.2 7025.3 7141.6 1124.2 1139.8 1143.6 1150.7 1151.7 5698.3 5700.3 5713.6 5723.3 5740.7 8779.0 8902.8 8992.5 9046.2 9151.4 8846.9 8931.6 8958.4 8965.0 8977.5 6690.1 6782.6 6848.5 6957.8 7048.4 6757.5 6848.7 6851.3 6877.9 6880.6 7765.5 7880.4 7913.6 7922.1 7942.4 7938.9 8113.2 8113.5 8153.3 8165.1 7105.1 7126.6 7185.2 7296.4 7337.1 7396.7 7405.2 7450.2 7475.5 7475.7 6833.7 6944.4 6974.5 7094.9 7157.5 6477.6 6776.2 6801.5 6864.0 6957.0 6691.1 6729.4 6745.6 6753.2 6764.7 5857.4 5890.9 6020.0 6047.2 6072.5 6291.7 6335.5 6379.2 6380.9 6402.0 09:50:16 INFO - 2015-11-20 09:50:16,316 DEBUG : BROWSER_OUTPUT: 09:50:16 INFO - 2015-11-20 09:50:16,316 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5610.07 Median:6429.91 stddev:1762.38 (27.4%) stddev-sans-first:1721.80 09:50:16 INFO - 2015-11-20 09:50:16,316 DEBUG : BROWSER_OUTPUT: Values: 307.5 310.5 315.3 316.4 322.4 6272.9 6390.4 6447.2 6492.0 6578.3 6298.2 6326.3 6355.3 6364.2 6367.3 4751.4 4754.1 4760.8 4762.7 4775.5 4704.5 4734.5 4735.8 4738.5 4777.2 4615.4 4703.5 4704.1 4720.6 4729.5 4705.9 4708.9 4713.9 4720.9 4730.5 4049.5 4050.7 4051.1 4054.7 4058.4 6058.9 6062.5 6062.9 6064.0 6064.4 5366.0 5469.5 5473.0 5474.5 5495.8 6694.9 6716.3 6717.7 6719.5 6728.6 4450.8 4454.0 4454.9 4459.8 4460.6 6843.2 6912.3 7004.0 7005.9 7017.3 4513.5 4515.5 4519.3 4527.3 4540.2 4581.7 4582.7 4592.2 4604.4 4611.7 5433.3 5436.4 5437.9 5442.0 5445.8 6636.0 6805.9 6811.9 6812.4 6839.4 1557.7 1599.7 1624.0 1628.1 1630.5 1017.5 1048.6 1063.8 1066.6 1072.5 6393.1 6429.3 6438.3 6446.6 6447.5 6878.7 6884.1 6898.3 6902.7 6916.9 6379.6 6428.2 6430.5 6437.8 6438.1 3797.0 3833.7 3836.4 3837.4 3841.1 7352.4 7356.5 7359.0 7364.0 7370.8 7084.6 7255.7 7264.6 7275.7 7297.0 7144.3 7151.9 7169.7 7189.9 7326.7 7004.4 7021.4 7044.1 7051.0 7057.2 6806.3 6967.4 6979.6 7000.2 7010.4 7319.2 7379.9 7386.9 7393.0 7398.4 4517.1 4572.0 4585.7 4589.2 4598.0 6824.5 6856.7 7013.0 7058.6 7106.0 6703.3 6817.7 6836.1 6856.9 6872.7 6859.1 6860.3 6861.2 6862.8 6865.4 6603.3 6679.7 6723.2 6728.4 6738.6 6891.5 6894.2 6908.6 6909.4 6911.5 6658.9 6663.1 6721.2 6737.0 6742.5 09:50:16 INFO - 2015-11-20 09:50:16,316 DEBUG : BROWSER_OUTPUT: 09:50:16 INFO - 2015-11-20 09:50:16,316 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13606.02 Median:46901.42 stddev:16172.58 (34.5%) stddev-sans-first:16189.16 09:50:16 INFO - 2015-11-20 09:50:16,317 DEBUG : BROWSER_OUTPUT: Values: 755.4 791.0 829.5 832.9 871.1 11979.6 12177.5 12203.6 12214.1 12234.6 12174.8 13056.8 13136.7 13175.9 13208.5 779.3 783.2 800.0 802.4 811.5 811.8 812.0 812.4 814.2 816.0 616.3 616.4 617.3 618.2 621.5 615.0 616.1 616.5 616.8 618.7 447.1 448.9 450.3 450.7 454.2 12379.4 12408.6 12420.9 12464.0 12495.4 11354.4 11422.8 11796.4 11900.8 12491.1 9758.5 9794.6 9978.8 10089.4 10240.1 3575.2 3598.2 3607.1 3607.3 3607.6 49242.8 49354.3 49432.3 49466.3 50105.5 9510.4 9764.1 9790.3 9906.3 9918.0 17628.7 17748.7 17843.6 17914.9 17942.1 7081.2 7126.0 7169.2 7378.2 7445.7 4007.0 4091.9 4095.5 4098.4 4128.7 3076.4 3103.3 3108.2 3115.7 3121.0 509.3 541.5 549.8 571.0 571.0 585.7 595.2 618.2 618.5 669.2 8024.8 8196.8 8273.9 8351.4 8748.9 519.5 537.7 587.7 649.6 678.7 3740.7 3834.7 3916.6 3922.0 3976.7 53680.0 60698.7 60913.0 61025.0 61878.0 50881.5 51633.0 51652.2 52282.2 52651.2 45271.8 45338.0 45876.3 47926.5 48338.3 8107.7 8115.6 8138.5 8260.7 8427.5 31989.4 32662.0 33849.8 35566.0 36091.8 40980.4 41217.0 42058.0 44172.8 45219.3 10309.2 10487.7 10976.3 11067.1 11324.7 11797.5 11963.0 11987.3 12004.5 12017.9 10294.5 10372.5 10499.7 10551.0 10620.9 11385.8 11436.1 11608.6 11720.2 12285.4 10491.9 10592.3 10788.6 10963.1 10968.7 9686.0 9717.6 9937.6 9948.6 10401.5 8477.2 8549.2 8649.5 8732.7 8963.4 09:50:16 INFO - 2015-11-20 09:50:16,317 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:50:16 INFO - 2015-11-20 09:50:16,318 DEBUG : BROWSER_OUTPUT: 09:50:17 INFO - 2015-11-20 09:50:17,007 INFO : Browser exited with error code: 0 09:50:17 INFO - 2015-11-20 09:50:17,026 INFO : Completed test dromaeo_css (00:18:32) 09:50:17 INFO - 2015-11-20 09:50:17,026 INFO : Starting test kraken 09:50:17 INFO - 2015-11-20 09:50:17,026 DEBUG : operating with platform_type : linux_ 09:50:17 INFO - 2015-11-20 09:50:17,026 INFO : Initialising browser for kraken test... 09:50:17 INFO - 2015-11-20 09:50:17,032 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqdYNoU/profile http://localhost:34584/getInfo.html 09:50:21 INFO - 2015-11-20 09:50:21,846 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:50:21 INFO - 2015-11-20 09:50:21,846 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:50:21 INFO - 2015-11-20 09:50:21,846 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:50:21 INFO - 2015-11-20 09:50:21,846 DEBUG : BROWSER_OUTPUT: __metrics 09:50:22 INFO - 2015-11-20 09:50:22,875 INFO : Browser initialized. 09:50:22 INFO - 2015-11-20 09:50:22,876 INFO : Running cycle 1/1 for kraken test... 09:50:22 INFO - 2015-11-20 09:50:22,876 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqdYNoU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:50:34 INFO - 2015-11-20 09:50:34,666 DEBUG : BROWSER_OUTPUT: RSS: Main: 141418496 09:50:34 INFO - 2015-11-20 09:50:34,666 DEBUG : BROWSER_OUTPUT: 09:50:37 INFO - 2015-11-20 09:50:37,142 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34584/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34584/tests/kraken/driver.html?testName=audio-beat-detection) 09:50:37 INFO - 2015-11-20 09:50:37,744 DEBUG : BROWSER_OUTPUT: RSS: Main: 141615104 09:50:37 INFO - 2015-11-20 09:50:37,744 DEBUG : BROWSER_OUTPUT: 09:50:40 INFO - 2015-11-20 09:50:40,373 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34584/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34584/tests/kraken/driver.html?testName=audio-dft) 09:50:40 INFO - 2015-11-20 09:50:40,968 DEBUG : BROWSER_OUTPUT: RSS: Main: 141844480 09:50:40 INFO - 2015-11-20 09:50:40,968 DEBUG : BROWSER_OUTPUT: 09:50:43 INFO - 2015-11-20 09:50:43,808 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34584/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34584/tests/kraken/driver.html?testName=audio-fft) 09:50:44 INFO - 2015-11-20 09:50:44,381 DEBUG : BROWSER_OUTPUT: RSS: Main: 136310784 09:50:44 INFO - 2015-11-20 09:50:44,381 DEBUG : BROWSER_OUTPUT: 09:50:46 INFO - 2015-11-20 09:50:46,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34584/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34584/tests/kraken/driver.html?testName=audio-oscillator) 09:50:46 INFO - 2015-11-20 09:50:46,960 DEBUG : BROWSER_OUTPUT: RSS: Main: 136945664 09:50:46 INFO - 2015-11-20 09:50:46,961 DEBUG : BROWSER_OUTPUT: 09:50:49 INFO - 2015-11-20 09:50:49,140 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34584/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34584/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:50:49 INFO - 2015-11-20 09:50:49,721 DEBUG : BROWSER_OUTPUT: RSS: Main: 137244672 09:50:49 INFO - 2015-11-20 09:50:49,721 DEBUG : BROWSER_OUTPUT: 09:50:52 INFO - 2015-11-20 09:50:52,725 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34584/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34584/tests/kraken/driver.html?testName=imaging-darkroom) 09:50:53 INFO - 2015-11-20 09:50:53,307 DEBUG : BROWSER_OUTPUT: RSS: Main: 137453568 09:50:53 INFO - 2015-11-20 09:50:53,307 DEBUG : BROWSER_OUTPUT: 09:50:56 INFO - 2015-11-20 09:50:56,710 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34584/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34584/tests/kraken/driver.html?testName=imaging-desaturate) 09:50:57 INFO - 2015-11-20 09:50:57,296 DEBUG : BROWSER_OUTPUT: RSS: Main: 138743808 09:50:57 INFO - 2015-11-20 09:50:57,296 DEBUG : BROWSER_OUTPUT: 09:51:00 INFO - 2015-11-20 09:51:00,181 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34584/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34584/tests/kraken/driver.html?testName=json-parse-financial) 09:51:00 INFO - 2015-11-20 09:51:00,767 DEBUG : BROWSER_OUTPUT: RSS: Main: 139124736 09:51:00 INFO - 2015-11-20 09:51:00,767 DEBUG : BROWSER_OUTPUT: 09:51:02 INFO - 2015-11-20 09:51:02,368 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34584/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34584/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:51:02 INFO - 2015-11-20 09:51:02,955 DEBUG : BROWSER_OUTPUT: RSS: Main: 139624448 09:51:02 INFO - 2015-11-20 09:51:02,955 DEBUG : BROWSER_OUTPUT: 09:51:04 INFO - 2015-11-20 09:51:04,805 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34584/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34584/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:51:05 INFO - 2015-11-20 09:51:05,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 139841536 09:51:05 INFO - 2015-11-20 09:51:05,414 DEBUG : BROWSER_OUTPUT: 09:51:07 INFO - 2015-11-20 09:51:07,512 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34584/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34584/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:51:08 INFO - 2015-11-20 09:51:08,102 DEBUG : BROWSER_OUTPUT: RSS: Main: 140087296 09:51:08 INFO - 2015-11-20 09:51:08,102 DEBUG : BROWSER_OUTPUT: 09:51:10 INFO - 2015-11-20 09:51:10,541 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34584/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34584/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:51:11 INFO - 2015-11-20 09:51:11,147 DEBUG : BROWSER_OUTPUT: RSS: Main: 140161024 09:51:11 INFO - 2015-11-20 09:51:11,147 DEBUG : BROWSER_OUTPUT: 09:51:13 INFO - 2015-11-20 09:51:13,755 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34584/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34584/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:51:14 INFO - 2015-11-20 09:51:14,337 DEBUG : BROWSER_OUTPUT: RSS: Main: 138690560 09:51:14 INFO - 2015-11-20 09:51:14,337 DEBUG : BROWSER_OUTPUT: 09:51:16 INFO - 2015-11-20 09:51:16,006 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34584/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34584/tests/kraken/driver.html?testName=ai-astar) 09:51:16 INFO - 2015-11-20 09:51:16,256 DEBUG : BROWSER_OUTPUT: RSS: Main: 138797056 09:51:16 INFO - 2015-11-20 09:51:16,256 DEBUG : BROWSER_OUTPUT: 09:51:16 INFO - 2015-11-20 09:51:16,257 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:51:16 INFO - 2015-11-20 09:51:16,257 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:51:16 INFO - 2015-11-20 09:51:16,257 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:51:16 INFO - 2015-11-20 09:51:16,257 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:51:16 INFO - 2015-11-20 09:51:16,257 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;109;109;110;110;123;110;109;109;111 09:51:16 INFO - 2015-11-20 09:51:16,258 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;128;150;168;128;155;145;126;165;129 09:51:16 INFO - 2015-11-20 09:51:16,258 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;163;162;164;164;163;162;165;171;162 09:51:16 INFO - 2015-11-20 09:51:16,258 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;72;73;73;73;74;143;73;73 09:51:16 INFO - 2015-11-20 09:51:16,258 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;91;133;89;92;90;136;91;91;133 09:51:16 INFO - 2015-11-20 09:51:16,258 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;110;109;110;110;109;111;110 09:51:16 INFO - 2015-11-20 09:51:16,258 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;147;147;150;147;150;148;148;147;147 09:51:16 INFO - 2015-11-20 09:51:16,258 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;96;96;95;106;96;96;96;96 09:51:16 INFO - 2015-11-20 09:51:16,259 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;60;63;61;61;64;62;66;62;62 09:51:16 INFO - 2015-11-20 09:51:16,259 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;70;69;71;69;69;69;68;70;68 09:51:16 INFO - 2015-11-20 09:51:16,259 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;85;86;86;85;93;85;86;85;87 09:51:16 INFO - 2015-11-20 09:51:16,259 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;124;120;121;118;126;123;122;121;119 09:51:16 INFO - 2015-11-20 09:51:16,259 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;144;150;165;151;172;149;157;161;145;143 09:51:16 INFO - 2015-11-20 09:51:16,259 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;74;67;66;67;67;70;68;68;66 09:51:16 INFO - 2015-11-20 09:51:16,259 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:51:16 INFO - 2015-11-20 09:51:16,260 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:51:16 INFO - 2015-11-20 09:51:16,260 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,721 09:51:16 INFO - 2015-11-20 09:51:16,260 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:51:16 INFO - 2015-11-20 09:51:16,260 DEBUG : BROWSER_OUTPUT: __startTimestamp1448041876255__endTimestamp 09:51:16 INFO - 2015-11-20 09:51:16,260 DEBUG : BROWSER_OUTPUT: 09:51:16 INFO - 2015-11-20 09:51:16,268 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:51:16 INFO - 2015-11-20 09:51:16,268 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:51:16 INFO - 2015-11-20 09:51:16,268 DEBUG : BROWSER_OUTPUT: 09:51:16 INFO - 2015-11-20 09:51:16,268 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.10 Median:110.00 stddev:4.25 (3.9%) stddev-sans-first:4.51 09:51:16 INFO - 2015-11-20 09:51:16,268 DEBUG : BROWSER_OUTPUT: Values: 111.0 109.0 109.0 110.0 110.0 123.0 110.0 109.0 109.0 111.0 09:51:16 INFO - 2015-11-20 09:51:16,268 DEBUG : BROWSER_OUTPUT: 09:51:16 INFO - 2015-11-20 09:51:16,268 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.00 Median:152.50 stddev:16.23 (10.6%) stddev-sans-first:16.72 09:51:16 INFO - 2015-11-20 09:51:16,268 DEBUG : BROWSER_OUTPUT: Values: 156.0 128.0 150.0 168.0 128.0 155.0 145.0 126.0 165.0 129.0 09:51:16 INFO - 2015-11-20 09:51:16,268 DEBUG : BROWSER_OUTPUT: 09:51:16 INFO - 2015-11-20 09:51:16,268 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.90 Median:163.50 stddev:2.69 (1.6%) stddev-sans-first:2.83 09:51:16 INFO - 2015-11-20 09:51:16,269 DEBUG : BROWSER_OUTPUT: Values: 163.0 163.0 162.0 164.0 164.0 163.0 162.0 165.0 171.0 162.0 09:51:16 INFO - 2015-11-20 09:51:16,269 DEBUG : BROWSER_OUTPUT: 09:51:16 INFO - 2015-11-20 09:51:16,269 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.90 Median:73.00 stddev:22.18 (30.4%) stddev-sans-first:23.34 09:51:16 INFO - 2015-11-20 09:51:16,269 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 72.0 73.0 73.0 73.0 74.0 143.0 73.0 73.0 09:51:16 INFO - 2015-11-20 09:51:16,269 DEBUG : BROWSER_OUTPUT: 09:51:16 INFO - 2015-11-20 09:51:16,269 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.60 Median:90.50 stddev:21.01 (23.2%) stddev-sans-first:21.70 09:51:16 INFO - 2015-11-20 09:51:16,269 DEBUG : BROWSER_OUTPUT: Values: 90.0 91.0 133.0 89.0 92.0 90.0 136.0 91.0 91.0 133.0 09:51:16 INFO - 2015-11-20 09:51:16,269 DEBUG : BROWSER_OUTPUT: 09:51:16 INFO - 2015-11-20 09:51:16,269 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 09:51:16 INFO - 2015-11-20 09:51:16,269 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 110.0 109.0 110.0 110.0 109.0 111.0 110.0 09:51:16 INFO - 2015-11-20 09:51:16,269 DEBUG : BROWSER_OUTPUT: 09:51:16 INFO - 2015-11-20 09:51:16,269 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.25 (0.8%) stddev-sans-first:1.27 09:51:16 INFO - 2015-11-20 09:51:16,269 DEBUG : BROWSER_OUTPUT: Values: 149.0 147.0 147.0 150.0 147.0 150.0 148.0 148.0 147.0 147.0 09:51:16 INFO - 2015-11-20 09:51:16,269 DEBUG : BROWSER_OUTPUT: 09:51:16 INFO - 2015-11-20 09:51:16,269 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:97.00 Median:96.00 stddev:3.20 (3.3%) stddev-sans-first:3.39 09:51:16 INFO - 2015-11-20 09:51:16,269 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 96.0 96.0 95.0 106.0 96.0 96.0 96.0 96.0 09:51:16 INFO - 2015-11-20 09:51:16,270 DEBUG : BROWSER_OUTPUT: 09:51:16 INFO - 2015-11-20 09:51:16,270 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.40 Median:62.50 stddev:1.71 (2.7%) stddev-sans-first:1.80 09:51:16 INFO - 2015-11-20 09:51:16,270 DEBUG : BROWSER_OUTPUT: Values: 63.0 60.0 63.0 61.0 61.0 64.0 62.0 66.0 62.0 62.0 09:51:16 INFO - 2015-11-20 09:51:16,270 DEBUG : BROWSER_OUTPUT: 09:51:16 INFO - 2015-11-20 09:51:16,270 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.50 stddev:0.95 (1.4%) stddev-sans-first:0.97 09:51:16 INFO - 2015-11-20 09:51:16,270 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 69.0 71.0 69.0 69.0 69.0 68.0 70.0 68.0 09:51:16 INFO - 2015-11-20 09:51:16,270 DEBUG : BROWSER_OUTPUT: 09:51:16 INFO - 2015-11-20 09:51:16,270 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:86.00 stddev:2.81 (3.3%) stddev-sans-first:2.55 09:51:16 INFO - 2015-11-20 09:51:16,270 DEBUG : BROWSER_OUTPUT: Values: 91.0 85.0 86.0 86.0 85.0 93.0 85.0 86.0 85.0 87.0 09:51:16 INFO - 2015-11-20 09:51:16,270 DEBUG : BROWSER_OUTPUT: 09:51:16 INFO - 2015-11-20 09:51:16,270 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:121.50 stddev:2.50 (2.1%) stddev-sans-first:2.51 09:51:16 INFO - 2015-11-20 09:51:16,270 DEBUG : BROWSER_OUTPUT: Values: 119.0 124.0 120.0 121.0 118.0 126.0 123.0 122.0 121.0 119.0 09:51:16 INFO - 2015-11-20 09:51:16,270 DEBUG : BROWSER_OUTPUT: 09:51:16 INFO - 2015-11-20 09:51:16,270 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.70 Median:154.00 stddev:9.74 (6.3%) stddev-sans-first:9.68 09:51:16 INFO - 2015-11-20 09:51:16,271 DEBUG : BROWSER_OUTPUT: Values: 144.0 150.0 165.0 151.0 172.0 149.0 157.0 161.0 145.0 143.0 09:51:16 INFO - 2015-11-20 09:51:16,271 DEBUG : BROWSER_OUTPUT: 09:51:16 INFO - 2015-11-20 09:51:16,271 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:2.38 (3.5%) stddev-sans-first:2.52 09:51:16 INFO - 2015-11-20 09:51:16,271 DEBUG : BROWSER_OUTPUT: Values: 68.0 74.0 67.0 66.0 67.0 67.0 70.0 68.0 68.0 66.0 09:51:16 INFO - 2015-11-20 09:51:16,271 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:51:16 INFO - 2015-11-20 09:51:16,271 DEBUG : BROWSER_OUTPUT: 09:51:17 INFO - 2015-11-20 09:51:17,127 INFO : Browser exited with error code: 0 09:51:17 INFO - 2015-11-20 09:51:17,177 INFO : Completed test kraken (00:01:00) 09:51:17 INFO - 2015-11-20 09:51:17,177 INFO : Starting test v8_7 09:51:17 INFO - 2015-11-20 09:51:17,177 DEBUG : operating with platform_type : linux_ 09:51:17 INFO - 2015-11-20 09:51:17,178 INFO : Initialising browser for v8_7 test... 09:51:17 INFO - 2015-11-20 09:51:17,184 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpW8mQTq/profile http://localhost:34584/getInfo.html 09:51:21 INFO - 2015-11-20 09:51:21,603 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:51:21 INFO - 2015-11-20 09:51:21,603 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:51:21 INFO - 2015-11-20 09:51:21,603 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:51:21 INFO - 2015-11-20 09:51:21,603 DEBUG : BROWSER_OUTPUT: __metrics 09:51:22 INFO - 2015-11-20 09:51:22,715 INFO : Browser initialized. 09:51:22 INFO - 2015-11-20 09:51:22,715 INFO : Running cycle 1/1 for v8_7 test... 09:51:22 INFO - 2015-11-20 09:51:22,716 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpW8mQTq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:51:34 INFO - 2015-11-20 09:51:34,570 DEBUG : BROWSER_OUTPUT: RSS: Main: 141504512 09:51:34 INFO - 2015-11-20 09:51:34,571 DEBUG : BROWSER_OUTPUT: 09:51:55 INFO - 2015-11-20 09:51:55,954 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34584/tests/v8_7/run.html (next: http://localhost:34584/tests/v8_7/run.html) 09:51:56 INFO - 2015-11-20 09:51:56,204 DEBUG : BROWSER_OUTPUT: RSS: Main: 138653696 09:51:56 INFO - 2015-11-20 09:51:56,204 DEBUG : BROWSER_OUTPUT: 09:51:56 INFO - 2015-11-20 09:51:56,204 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:51:56 INFO - 2015-11-20 09:51:56,204 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:51:56 INFO - 2015-11-20 09:51:56,204 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:51:56 INFO - 2015-11-20 09:51:56,204 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:51:56 INFO - 2015-11-20 09:51:56,205 DEBUG : BROWSER_OUTPUT: |0;Richards;166.05778811026238 09:51:56 INFO - 2015-11-20 09:51:56,205 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.05019305019306 09:51:56 INFO - 2015-11-20 09:51:56,205 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.56569652444193 09:51:56 INFO - 2015-11-20 09:51:56,205 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 09:51:56 INFO - 2015-11-20 09:51:56,205 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1070.6638115631692 09:51:56 INFO - 2015-11-20 09:51:56,205 DEBUG : BROWSER_OUTPUT: |5;Earley;711.7437722419929 09:51:56 INFO - 2015-11-20 09:51:56,205 DEBUG : BROWSER_OUTPUT: |6;Boyer;12382.716049382716 09:51:56 INFO - 2015-11-20 09:51:56,205 DEBUG : BROWSER_OUTPUT: |7;RegExp;25125 09:51:56 INFO - 2015-11-20 09:51:56,205 DEBUG : BROWSER_OUTPUT: |8;Splay;628.5355122564425 09:51:56 INFO - 2015-11-20 09:51:56,205 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4906.862745098039 09:51:56 INFO - 2015-11-20 09:51:56,205 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:51:56 INFO - 2015-11-20 09:51:56,205 DEBUG : BROWSER_OUTPUT: __startTimestamp1448041916202__endTimestamp 09:51:56 INFO - 2015-11-20 09:51:56,206 DEBUG : BROWSER_OUTPUT: 09:51:56 INFO - 2015-11-20 09:51:56,206 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:51:56 INFO - 2015-11-20 09:51:56,206 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:51:56 INFO - 2015-11-20 09:51:56,206 DEBUG : BROWSER_OUTPUT: 09:51:56 INFO - 2015-11-20 09:51:56,206 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.06 Median:166.06 stddev:0.00 (0.0%) 09:51:56 INFO - 2015-11-20 09:51:56,206 DEBUG : BROWSER_OUTPUT: Values: 166.1 09:51:56 INFO - 2015-11-20 09:51:56,206 DEBUG : BROWSER_OUTPUT: 09:51:56 INFO - 2015-11-20 09:51:56,206 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.05 Median:193.05 stddev:0.00 (0.0%) 09:51:56 INFO - 2015-11-20 09:51:56,206 DEBUG : BROWSER_OUTPUT: Values: 193.1 09:51:56 INFO - 2015-11-20 09:51:56,206 DEBUG : BROWSER_OUTPUT: 09:51:56 INFO - 2015-11-20 09:51:56,207 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.57 Median:282.57 stddev:0.00 (0.0%) 09:51:56 INFO - 2015-11-20 09:51:56,207 DEBUG : BROWSER_OUTPUT: Values: 282.6 09:51:56 INFO - 2015-11-20 09:51:56,207 DEBUG : BROWSER_OUTPUT: 09:51:56 INFO - 2015-11-20 09:51:56,207 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 09:51:56 INFO - 2015-11-20 09:51:56,207 DEBUG : BROWSER_OUTPUT: Values: 5040.2 09:51:56 INFO - 2015-11-20 09:51:56,207 DEBUG : BROWSER_OUTPUT: 09:51:56 INFO - 2015-11-20 09:51:56,208 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1070.66 Median:1070.66 stddev:0.00 (0.0%) 09:51:56 INFO - 2015-11-20 09:51:56,208 DEBUG : BROWSER_OUTPUT: Values: 1070.7 09:51:56 INFO - 2015-11-20 09:51:56,208 DEBUG : BROWSER_OUTPUT: 09:51:56 INFO - 2015-11-20 09:51:56,208 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:711.74 Median:711.74 stddev:0.00 (0.0%) 09:51:56 INFO - 2015-11-20 09:51:56,208 DEBUG : BROWSER_OUTPUT: Values: 711.7 09:51:56 INFO - 2015-11-20 09:51:56,209 DEBUG : BROWSER_OUTPUT: 09:51:56 INFO - 2015-11-20 09:51:56,209 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12382.72 Median:12382.72 stddev:0.00 (0.0%) 09:51:56 INFO - 2015-11-20 09:51:56,209 DEBUG : BROWSER_OUTPUT: Values: 12382.7 09:51:56 INFO - 2015-11-20 09:51:56,209 DEBUG : BROWSER_OUTPUT: 09:51:56 INFO - 2015-11-20 09:51:56,210 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25125.00 Median:25125.00 stddev:0.00 (0.0%) 09:51:56 INFO - 2015-11-20 09:51:56,210 DEBUG : BROWSER_OUTPUT: Values: 25125.0 09:51:56 INFO - 2015-11-20 09:51:56,210 DEBUG : BROWSER_OUTPUT: 09:51:56 INFO - 2015-11-20 09:51:56,210 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:628.54 Median:628.54 stddev:0.00 (0.0%) 09:51:56 INFO - 2015-11-20 09:51:56,211 DEBUG : BROWSER_OUTPUT: Values: 628.5 09:51:56 INFO - 2015-11-20 09:51:56,211 DEBUG : BROWSER_OUTPUT: 09:51:56 INFO - 2015-11-20 09:51:56,211 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4906.86 Median:4906.86 stddev:0.00 (0.0%) 09:51:56 INFO - 2015-11-20 09:51:56,211 DEBUG : BROWSER_OUTPUT: Values: 4906.9 09:51:56 INFO - 2015-11-20 09:51:56,211 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:51:56 INFO - 2015-11-20 09:51:56,211 DEBUG : BROWSER_OUTPUT: 09:51:57 INFO - 2015-11-20 09:51:57,099 INFO : Browser exited with error code: 0 09:51:57 INFO - 2015-11-20 09:51:57,113 INFO : Completed test v8_7 (00:00:39) 09:51:57 INFO - 2015-11-20 09:51:57,271 INFO : Completed test suite (00:20:12) 09:51:57 INFO - 2015-11-20 09:51:57,272 DEBUG : Working with test: dromaeo_css 09:51:57 INFO - 2015-11-20 09:51:57,272 DEBUG : Generating results file: dromaeo_css 09:51:57 INFO - 2015-11-20 09:51:57,273 DEBUG : Working with test: kraken 09:51:57 INFO - 2015-11-20 09:51:57,273 DEBUG : Generating results file: kraken 09:51:57 INFO - 2015-11-20 09:51:57,273 INFO : javascript benchmark 09:51:57 INFO - 2015-11-20 09:51:57,273 DEBUG : Working with test: v8_7 09:51:57 INFO - 2015-11-20 09:51:57,273 DEBUG : Generating results file: v8_7 09:51:57 INFO - 2015-11-20 09:51:57,274 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:51:57 INFO - 2015-11-20 09:51:57,337 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 09:51:57 INFO - 2015-11-20 09:51:57,337 DEBUG : process_Request line: dromaeo_css 6884.07 graph.html#tests=[[72,63,43]] 09:51:57 INFO - 2015-11-20 09:51:57,337 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:51:57 INFO - 2015-11-20 09:51:57,363 DEBUG : process_Request line: kraken 1519.90 graph.html#tests=[[232,63,43]] 09:51:57 INFO - 2015-11-20 09:51:57,363 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:51:57 INFO - 2015-11-20 09:51:57,393 DEBUG : process_Request line: v8_7 21237.13 graph.html#tests=[[230,63,43]] 09:51:57 INFO - 2015-11-20 09:51:57,394 INFO : javascript benchmark 09:51:57 INFO - 2015-11-20 09:51:57,398 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3223.3231021485485, 3255.886043988461, 3290.7696461247724, 3308.421026320394, 3324.052644996175, 5189.662671926322, 5403.972980135099, 5433.782648694052, 5452.672839629625, 5463.562914966803, 5386.91919621205, 5405.243265942761, 5444.863878403032, 5535.557155427567, 5540.778368865241, 4934.802607895689, 4993.975030124862, 5030.6981581105065, 5051.7726702298305, 5053.519915608012, 4905.0, 4981.103401387749, 4981.1335723246175, 5036.7733451994745, 5086.898262034757, 4766.523347665206, 4883.438404583483, 4916.164252077119, 5020.372453443338, 5036.597072234213, 4896.290037944478, 4979.929315197213, 4988.501149885019, 4993.950060499421, 5009.749512524396, 4927.1870141426625, 4953.306537084811, 4955.430125535538, 4968.87577810554, 4969.950300496985, 5121.590272778169, 5201.765920533585, 5248.895022099537, 5260.351520648209, 5284.815031473919, 5744.195812586241, 5866.413358664142, 5941.524678025791, 5947.316058653267, 5992.041273396279, 5828.329742079631, 5883.558733094992, 5891.911621325684, 5940.435658612425, 6006.609570377911, 5364.785408583691, 5510.421405752419, 5520.723963801834, 5523.226748255248, 5531.668099914018, 5792.88414231713, 5907.4683278505145, 5965.373635768182, 5970.940290597126, 5991.981363168272, 5731.856703582361, 5740.454656807597, 5750.281214848144, 5760.654360738369, 5833.387494313036, 5805.8548536286935, 5813.593048486566, 5860.882782344329, 5920.851978700481, 5923.881522369528, 5776.480116789509, 5838.708064596838, 5849.88300233993, 5854.912176317359, 5872.706364681749, 5839.328477225174, 5844.444777746107, 5921.822345329647, 5922.703864806743, 5932.199153114274, 4414.492333381638, 4477.932831007537, 4487.326900964881, 4534.183846907522, 4573.222552166139, 3947.5657677655436, 4029.0934539728914, 4045.0898547826505, 4045.7977101144825, 4065.5527891931865, 5606.579506536945, 5620.044592419298, 5630.436956304418, 5634.7182640867795, 5642.238297829823, 5733.799317023884, 5872.354041055481, 5936.257967754031, 5941.22764040672, 5941.70291485424, 5501.807436739775, 5572.554195664337, 5581.720913954286, 5585.525230355384, 5646.85882852932, 5106.565941894906, 5147.845564633067, 5166.769181928234, 5170.121079416508, 5207.609429292818, 5881.911771323434, 5941.168236446901, 5995.400459954057, 6090.908636370458, 6112.205413296243, 5936.5844390892225, 5970.641761494324, 5979.461848433488, 6000.759969601341, 6019.18740969981, 6093.847653808513, 6098.634081955097, 6102.786402475892, 6112.0, 6124.173236613, 5645.294338207724, 5703.0, 5737.08206686928, 5898.498627616701, 5898.557608179318, 5860.120981852756, 5867.442592953663, 5872.148538461985, 5876.294844618673, 5959.255093113361, 5658.971705141448, 5694.772209111589, 5696.088625819849, 5697.373288938131, 5700.315962084576, 5552.305961754781, 5623.606347555632, 5663.830085097454, 5687.43125687428, 5788.334341550607, 5584.553235741212, 5617.915731264116, 5630.60585758993, 5635.520980716685, 5653.038983372754, 5732.16883551891, 5734.799282025109, 5767.163761254678, 5783.363829978614, 5791.82624521265, 5484.506394424361, 5568.192612071308, 5626.32484101894, 5707.7716891325545, 5778.797742079007], "unit": "ms", "name": "dojo.html", "value": 5406.0704859867255}, {"lowerIsBetter": false, "replicates": [584.8157830283461, 588.9676067816271, 591.3347484080408, 602.9517638588914, 617.4813156948163, 39573.80213098934, 40005.39991900124, 40209.79895100528, 40283.59716402839, 40433.59566404335, 42667.146657066914, 42932.78533607336, 43166.13667726643, 43278.13443731124, 43288.35067473983, 8727.258183054448, 8825.073367296438, 8862.645494180257, 8871.733847984538, 8886.511241881693, 8579.356548258875, 8593.0, 8610.612522436506, 8631.43895646781, 8641.65433382664, 8470.32237421008, 8601.096884827097, 8626.870596941051, 8640.697575584856, 8650.26472749817, 8628.22345988864, 8645.567721613925, 8679.652813887436, 8722.912770872304, 8723.869141962876, 8509.149085091503, 8594.054653988056, 8612.0, 8650.178233067849, 8650.65397384104, 39964.800175999226, 40391.7980410099, 40523.7973810132, 40556.0, 40583.59416405857, 3242.9946716517957, 3312.453445181542, 3626.38351480249, 3909.1331292540685, 3926.6466018058513, 29738.702612974026, 30771.230719231975, 30772.846135769178, 30842.69157308443, 31586.36827263442, 3925.8429662813455, 4030.496187976503, 4032.717709760318, 4077.7145599808027, 4160.625543701051, 282537.0, 284456.0, 285217.0, 286878.0, 287050.564747177, 51079.48920510747, 61052.389476105556, 61065.694671526355, 61167.69416152891, 61182.69408653017, 49843.50156498388, 71207.0, 71440.28559714441, 71588.64205678938, 71659.64170179116, 15840.60398490047, 15959.122248276457, 15967.60080997961, 16022.919885400499, 16049.759253611206, 11842.348670823187, 12121.0, 12129.15095943293, 12134.75730485403, 12213.0, 20171.697424538645, 20262.594748104955, 20336.186552538027, 20457.48856278605, 20540.5351357838, 7947.205279472007, 8123.512589244664, 8158.2657560818625, 8239.134890836376, 8254.298384637254, 1037.2894567221476, 1037.419045334615, 1058.9713419619882, 1084.5228099636136, 1104.4091411095026, 28295.29261768472, 28530.429391412057, 28688.426231475252, 28818.567721484196, 29117.7088229115, 1043.3479075577764, 1065.4033741105006, 1072.9302595331435, 1073.656429942411, 1084.3277168155794, 14831.703365932837, 14925.92537037308, 14963.40146394132, 15052.397904083933, 15230.543083707507, 297606.0, 297893.0, 299427.0, 300207.0, 302038.0, 51927.0, 51964.48035519672, 52163.73918130385, 52402.47597523976, 52411.59324643886, 1331.4075236519657, 1355.1733442600007, 1365.4060483689627, 1367.1045465220298, 1372.1904076594858, 27243.727562724118, 28537.714622854335, 28550.57174142431, 28610.713892860804, 28849.42301154007, 46959.765201173774, 47247.52752472431, 47318.29022564596, 47426.52573474221, 47480.0, 280877.0, 282441.0, 282535.0, 282977.0, 283055.0, 32995.83502082474, 45305.773471133754, 45539.54460455485, 45875.08249834918, 46675.032622226136, 44023.339649905916, 44034.33948490711, 44707.776461117486, 44882.55117448914, 45283.320750189436, 36480.27039459249, 36529.26941461103, 36551.45172822357, 37989.0, 38160.0, 36221.63778362288, 36986.8150659245, 37434.43848342223, 37585.43621845729, 37719.24561508809, 36164.819175903955, 36777.81611091927, 37212.627873720914, 37259.254814903004, 37271.44092838556, 32814.83592582022, 33445.49831752477, 34162.82918585391, 34203.31593368168, 36595.451068233466, 25530.328264122734, 25630.0, 25790.13026774209, 25921.870390647928, 25971.740282596933], "unit": "ms", "name": "ext.html", "value": 19023.36658419394}, {"lowerIsBetter": false, "replicates": [354.675471943172, 355.10867722017736, 356.81445648262905, 357.17136243914115, 359.1541918781268, 16501.999999999985, 17303.134843257834, 17468.65062698745, 18237.36169234077, 18348.449546513624, 16194.676106477864, 16432.17839108043, 16582.66834663309, 16639.084850333256, 17064.744028839577, 4616.538346165382, 4703.576678098971, 4716.1982462981205, 4743.478217396084, 4756.334113224151, 4652.255639097745, 4721.952780472186, 4775.212090005145, 4778.2115950868065, 4800.447948485917, 4775.188218002948, 4787.234042553192, 4837.830675926343, 4977.47736487669, 4985.077760614298, 4974.577160941324, 5014.348134742497, 5022.146235140035, 5024.623153263502, 5032.270320803481, 5186.273921650972, 5210.843674689765, 5235.842924712227, 5236.371635403738, 5242.872782351813, 11140.554377824958, 11255.155863310203, 13645.590632281048, 18622.16200270991, 18703.251869925185, 2042.3668662714606, 2068.327793467129, 2091.7699053104147, 2120.7349081364828, 2124.2883633982633, 8959.910400895973, 9186.678466253716, 11965.46155423008, 12115.575954841626, 12856.707728105683, 1817.7727784026997, 1819.3268490658409, 1830.8901465912088, 1847.2980267498265, 1850.1119462658, 56738.71630641862, 59018.0, 59376.70311648414, 59575.40424595742, 60021.0, 9865.112139907444, 9875.111239988435, 9886.060824221688, 9897.416413373825, 9915.851262231072, 12651.0, 12679.0, 12679.873201267868, 12683.175593586388, 12720.6819829505, 7057.047298614724, 7638.121616014118, 7661.0, 7667.731629393056, 7695.730649427243, 7375.668094935741, 7385.741499047507, 7389.630518474055, 7404.96297518509, 7447.664855081534, 3941.2117576484816, 4065.593440655911, 4121.9381709274385, 4192.140611174702, 4268.359746038057, 1663.717168081429, 1665.5669525923347, 1684.0400971446402, 1770.69012922738, 1770.9203085860909, 374.83881930769485, 376.63842710997204, 379.4876916163213, 382.0753775862364, 394.51080659981415, 9593.088656577615, 10198.18414526836, 10419.114375278035, 10451.790964180675, 10728.141748660088, 367.4231456613092, 914.9588268527932, 927.5733162745078, 931.4737173496952, 950.4012472142506, 5568.276124103841, 5570.0, 5740.54075673945, 9049.547522623843, 9542.236621070298, 531223.0, 535329.0, 552647.0, 566992.0, 576569.0, 80251.19748802554, 83914.0, 84386.0, 84621.0, 85207.0, 432.28456903824224, 434.87171284471157, 438.38625923707065, 438.72141190343723, 442.3166208208326, 9726.319157658896, 9777.0, 9859.753506162404, 10058.849117263393, 10272.280940334404, 36758.63241367552, 37004.25991480209, 37269.0, 37794.8110259458, 39016.0, 47503.287450687574, 48238.27642585434, 48251.75874120607, 48509.0, 48509.5149048505, 9111.908880911105, 9322.254219662274, 9816.460094694861, 9836.311458197857, 9850.310478266452, 16660.50018499447, 17062.317507300064, 17087.31650733957, 17407.56481087983, 17419.39032133869, 13426.597202083953, 14179.078359906573, 14271.928640357148, 14339.354729037426, 14908.850911490747, 13692.794608080687, 13739.106958047694, 13826.239556824472, 14186.858131418554, 14443.422263109358, 13975.301234938415, 14196.432142714175, 14305.642358940693, 14487.275636218357, 14664.780028299798, 8567.571621419029, 8645.394822362627, 8669.003064647393, 8693.478391296543, 8733.694320698745, 9343.205827504738, 9365.765855853659, 9485.288603354638, 13580.25308608036, 14129.293535322988], "unit": "ms", "name": "jquery.html", "value": 7895.2061335614335}, {"lowerIsBetter": false, "replicates": [1475.667974705691, 1510.886683498738, 1617.90292582445, 1654.8014238291407, 1771.291483406638, 7017.228104908469, 7169.318914703108, 7601.429892758045, 7757.883631745522, 7775.0, 7636.656350464228, 7691.461597688164, 7754.844903101949, 7782.299593036626, 7802.180771019032, 1982.415187519685, 2026.0, 2029.2390353617393, 2035.7557093148844, 2041.0, 2217.1796435318956, 2234.229190929127, 2238.944026399337, 2256.4246117240164, 2261.1407665087245, 1915.7509523761962, 1964.5776158126, 2143.614149453098, 2163.0482587661377, 2168.0, 2092.905819238138, 2139.529303553216, 2139.914403423869, 2140.871547707143, 2141.65733482642, 2134.4557137929883, 2148.4736239621393, 2209.8674079555276, 2211.237123192496, 2212.6349152389835, 7467.9626601867185, 7534.510256833289, 7542.35889949355, 7565.43259255558, 7573.772786816405, 4407.647388208936, 4442.311441726538, 4493.820247190109, 4505.977470112662, 4521.050579378334, 2948.9557656635166, 2988.5517172424093, 2989.2676294307817, 3030.575719399286, 3089.413011527825, 989.569537251298, 1039.3140527252053, 1040.708601591548, 1816.6548355812486, 1864.794872564017, 10127.746806329827, 10328.173746100369, 10340.948295258475, 10386.428746418944, 10413.843792343197, 3870.283997460479, 3882.592327805596, 3912.491376121086, 3939.094008378032, 3986.421968814506, 8285.95857020723, 8352.958235208785, 8356.70751523706, 8366.330693544502, 8418.242358187792, 4495.280755079171, 4504.414426124583, 4507.2788353863225, 4510.954890451054, 4526.547345265513, 4161.687873409506, 4174.645155161785, 4202.831886724558, 4204.348326009474, 4214.136102099063, 3391.2369716814014, 3393.185635447475, 3412.505186747908, 3426.0578340956436, 3426.229098452828, 1051.4795176387738, 1064.984025239622, 1067.8985496377832, 1069.1072954083427, 1073.1468482556386, 1035.570238351091, 1044.5038606661774, 1045.639254457211, 1289.8194252804615, 1317.7891537353978, 6886.655667216719, 6998.125234345707, 6999.23008469068, 7025.332593403618, 7141.607211603412, 1124.1793490751797, 1139.800534906388, 1143.6111722014555, 1150.715829079277, 1151.6775302915198, 5698.259226300637, 5700.287464066992, 5713.628614140068, 5723.284589426322, 5740.741666625012, 8779.03430622631, 8902.821943561092, 8992.46045237288, 9046.231070358961, 9151.405158664666, 8846.911530884738, 8931.598078086501, 8958.372913895964, 8965.0, 8977.50623715689, 6690.13028306317, 6782.559133656297, 6848.520603557703, 6957.826054348682, 7048.400885924651, 6757.459403247827, 6848.657567121723, 6851.3491218334175, 6877.931220687929, 6880.58716477013, 7765.495242809199, 7880.448368614142, 7913.564753938589, 7922.0889597697005, 7942.404319675932, 7938.880916786368, 8113.229243221885, 8113.5131892086665, 8153.306968907472, 8165.061017983008, 7105.147382314155, 7126.608036558039, 7185.209626940928, 7296.4162866969455, 7337.0828646419195, 7396.704131834666, 7405.185429602631, 7450.180480147071, 7475.514091584029, 7475.738349157971, 6833.6674348501565, 6944.444444444332, 6974.4769142315545, 7094.858102838018, 7157.463190260647, 6477.578957367756, 6776.15298087739, 6801.455883529206, 6864.0, 6957.0, 6691.063251144747, 6729.394354507922, 6745.561538499982, 6753.189617245962, 6764.729410823709, 5857.384974577608, 5890.911636325544, 6020.036794112921, 6047.213862198062, 6072.514198863992, 6291.748330066929, 6335.524835637253, 6379.2344918608205, 6380.872382552416, 6402.0], "unit": "ms", "name": "mootools.html", "value": 4361.178414224077}, {"lowerIsBetter": false, "replicates": [307.4573377987851, 310.45360166107656, 315.2544232889216, 316.446219116546, 322.36654972978096, 6272.874542509153, 6390.424861762441, 6447.2263328400595, 6492.026196070586, 6578.309277525863, 6298.244210694712, 6326.304106548276, 6355.332690067546, 6364.204474440695, 6367.331430199832, 4751.40607424072, 4754.072955773626, 4760.7619619019, 4762.738049407281, 4775.474697783241, 4704.45898721648, 4734.502877197879, 4735.786889589976, 4738.502457241992, 4777.235642297233, 4615.399998000272, 4703.459102203256, 4704.059188162364, 4720.59874910633, 4729.50340214276, 4705.929411058837, 4708.882277943045, 4713.882152946187, 4720.929186062212, 4730.503297153784, 4049.453323801308, 4050.736702114353, 4051.1290072634524, 4054.736442131252, 4058.391241313797, 6058.939410605882, 6062.514998800086, 6062.9090563641585, 6064.0, 6064.3935606439445, 5366.0, 5469.535089517396, 5472.972635136839, 5474.479924407215, 5495.780168793243, 6694.899576506356, 6716.294789047129, 6717.731290748364, 6719.496037797136, 6728.562643428161, 4450.755208463534, 4454.020115574568, 4454.933176002362, 4459.843905463325, 4460.6208472279895, 6843.247242803288, 6912.308769123098, 7004.0, 7005.894911576331, 7017.333353331476, 4513.458384993756, 4515.503294637587, 4519.344695019269, 4527.253003254426, 4540.228161212602, 4581.702189357681, 4582.747948862778, 4592.2193227151465, 4604.37840891482, 4611.654125940568, 5433.320834895638, 5436.429174936575, 5437.891242175214, 5441.972790136103, 5445.83662490126, 6635.966820165965, 6805.863882722318, 6811.897821532681, 6812.386885180357, 6839.384455398938, 1557.6573153906122, 1599.6720672262159, 1624.0499307905009, 1628.0638632786195, 1630.5026966775247, 1017.4658304390255, 1048.5858086055964, 1063.787282497953, 1066.5520481397832, 1072.4905669806935, 6393.104965304861, 6429.32492088324, 6438.323975982548, 6446.645434501053, 6447.516436267205, 6878.7248510060035, 6884.139482564679, 6898.275681053417, 6902.654867256617, 6916.930830691729, 6379.617222966637, 6428.19647544057, 6430.485561155097, 6437.774677886251, 6438.098666186737, 3796.962030379716, 3833.7124715646437, 3836.366999445116, 3837.3860182370686, 3841.0589405595806, 7352.411807055422, 7356.521826081287, 7358.963205184047, 7364.0, 7370.815729606696, 7084.645767711697, 7255.709771609077, 7264.636768161571, 7275.745348912763, 7296.96351518239, 7144.285571442918, 7151.928480715231, 7169.713211471482, 7189.92810071903, 7326.670299836626, 7004.439644828503, 7021.43828493709, 7044.084269045196, 7051.048108505286, 7057.2237053923, 6806.285340039224, 6967.407770339578, 6979.616121113185, 7000.194977577644, 7010.404115650227, 7319.231480694663, 7379.926200737924, 7386.926130738624, 7393.0, 7398.445116616383, 4517.09658068381, 4572.0, 4585.656075794262, 4589.196890544074, 4598.034412773221, 6824.454043676593, 6856.691448884912, 7012.964935175291, 7058.6470676467, 7106.040684507525, 6703.262641109572, 6817.659117044029, 6836.077129587442, 6856.9314306856295, 6872.69072891711, 6859.142607174103, 6860.348266914635, 6861.210960739579, 6862.759803406857, 6865.382115609619, 6603.273639899703, 6679.699413526306, 6723.226828914738, 6728.394444499822, 6738.629375384401, 6891.517593768388, 6894.24163342042, 6908.585484870924, 6909.378155965987, 6911.481638877004, 6658.866822663423, 6663.067170596218, 6721.193456785217, 6737.023131645982, 6742.494312926452], "unit": "ms", "name": "prototype.html", "value": 5015.271498226946}, {"lowerIsBetter": false, "replicates": [755.4183278875266, 790.9762707118789, 829.5022986208272, 832.8875601793756, 871.0505548951644, 11979.580714674978, 12177.452014659339, 12203.57287494938, 12214.083943704214, 12234.632961011162, 12174.81737773934, 13056.804147937788, 13136.6715832104, 13175.868241317585, 13208.537701180461, 779.2558107007794, 783.1972228465811, 799.9960000199991, 802.3701394405393, 811.4968719393984, 811.8213992921548, 811.979700507489, 812.3907069697726, 814.2346194577108, 816.0330008939396, 616.2974209401286, 616.4298024327502, 617.3363634093345, 618.2395653346364, 621.4779585148474, 614.984625384369, 616.0758861707438, 616.4513582911212, 616.7625464196271, 618.7308520793447, 447.1437197766274, 448.93714879916837, 450.3065279469613, 450.6957803482669, 454.1779379323435, 12379.381030948416, 12408.56570020054, 12420.875791242062, 12464.0, 12495.437705303193, 11354.43227838613, 11422.771544569145, 11796.410179491077, 11900.821487677691, 12491.063170262267, 9758.487434447672, 9794.608215671436, 9978.750531236705, 10089.445080520569, 10240.129588984944, 3575.2134530403528, 3598.24436868258, 3607.134287770942, 3607.278544291126, 3607.5851277103206, 49242.753786231195, 49354.259686104735, 49432.25851612229, 49466.25800612994, 50105.49894501081, 9510.38182518134, 9764.072413120743, 9790.314677972474, 9906.306558540833, 9917.950410247902, 17628.735568966476, 17748.733768993476, 17843.553911152325, 17914.91042544805, 17942.102894855205, 7081.185663648644, 7125.964370178116, 7169.211386747454, 7378.225286344857, 7445.739399121005, 4006.979965100156, 4091.85678501251, 4095.508538975342, 4098.446709694213, 4128.731632443882, 3076.4308602908086, 3103.2707313781243, 3108.2074071112174, 3115.7195852373397, 3120.953185702216, 509.28191250336846, 541.4855886907375, 549.815811703076, 570.9800156994485, 571.0235497299581, 585.6690969602162, 595.169738215196, 618.2364779497317, 618.4557589321458, 669.2270427656065, 8024.79938001543, 8196.795080123045, 8273.863068465767, 8351.415400921998, 8748.912510874938, 519.462356461061, 537.6800803521899, 587.7472686744741, 649.6102338596804, 678.6538865178794, 3740.663340299386, 3834.7123965702685, 3916.58875818035, 3921.9607803921594, 3976.721629485908, 53680.0, 60698.69650651807, 60913.0, 61025.0, 61878.0, 50881.49118508842, 51633.0, 51652.22521662103, 52282.215766763526, 52651.210231846555, 45271.77364113224, 45338.0, 45876.311855322194, 47926.5207347929, 48338.27492587614, 8107.675692972215, 8115.59422028908, 8138.511689298661, 8260.710875119583, 8427.544706670236, 31989.36021279608, 32662.0, 33849.830750846086, 35566.0, 36091.81954090213, 40980.3852942212, 41217.0, 42058.0, 44172.779136104116, 45219.32171017372, 10309.175265978554, 10487.685369438928, 10976.341419514854, 11067.114630829354, 11324.66553608456, 11797.469113889723, 11963.0, 11987.34069626179, 12004.519819207135, 12017.879821201675, 10294.536745846304, 10372.484573042348, 10499.68500944973, 10551.0, 10620.89379106199, 11385.772284554097, 11436.085113190758, 11608.593699220486, 11720.179587428798, 12285.385730713608, 10491.895081049091, 10592.311499752492, 10788.568457261621, 10963.068139208257, 10968.725781855199, 9686.0, 9717.611295548098, 9937.602495900372, 9948.602055917681, 10401.53193106297, 8477.23704866565, 8549.187827156411, 8649.524276164871, 8732.65069397217, 8963.372563920462], "unit": "ms", "name": "yui.html", "value": 5992.437319169101}], "name": "dromaeo_css", "value": 6884.072589099727}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 109.0, 110.0, 110.0, 123.0, 110.0, 109.0, 109.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [156.0, 128.0, 150.0, 168.0, 128.0, 155.0, 145.0, 126.0, 165.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 145.0}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 162.0, 164.0, 164.0, 163.0, 162.0, 165.0, 171.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 163.9}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 72.0, 73.0, 73.0, 73.0, 74.0, 143.0, 73.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 79.9}, {"lowerIsBetter": true, "replicates": [90.0, 91.0, 133.0, 89.0, 92.0, 90.0, 136.0, 91.0, 91.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 103.6}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 109.0, 110.0, 110.0, 109.0, 111.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [149.0, 147.0, 147.0, 150.0, 147.0, 150.0, 148.0, 148.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.0}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 96.0, 95.0, 106.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 97.0}, {"lowerIsBetter": true, "replicates": [63.0, 60.0, 63.0, 61.0, 61.0, 64.0, 62.0, 66.0, 62.0, 62.0], "unit": "ms", "name": "json-parse-financial", "value": 62.4}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 69.0, 71.0, 69.0, 69.0, 69.0, 68.0, 70.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [91.0, 85.0, 86.0, 86.0, 85.0, 93.0, 85.0, 86.0, 85.0, 87.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.9}, {"lowerIsBetter": true, "replicates": [119.0, 124.0, 120.0, 121.0, 118.0, 126.0, 123.0, 122.0, 121.0, 119.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.3}, {"lowerIsBetter": true, "replicates": [144.0, 150.0, 165.0, 151.0, 172.0, 149.0, 157.0, 161.0, 145.0, 143.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 153.7}, {"lowerIsBetter": true, "replicates": [68.0, 74.0, 67.0, 66.0, 67.0, 67.0, 70.0, 68.0, 68.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.1}], "name": "kraken", "value": 1519.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.05778811026238], "unit": "score", "name": "Richards", "value": 212.58864400000002}, {"lowerIsBetter": false, "replicates": [193.05019305019306], "unit": "score", "name": "DeltaBlue", "value": 342.49123999999995}, {"lowerIsBetter": false, "replicates": [282.56569652444193], "unit": "score", "name": "Encrypt", "value": 942.0145590000004}, {"lowerIsBetter": false, "replicates": [5040.201005025126], "unit": "score", "name": "Decrypt", "value": 52.81158424725827}, {"lowerIsBetter": false, "replicates": [1070.6638115631692], "unit": "score", "name": "RayTrace", "value": 691.1497260000002}, {"lowerIsBetter": false, "replicates": [711.7437722419929], "unit": "score", "name": "Earley", "value": 936.3805150000001}, {"lowerIsBetter": false, "replicates": [12382.716049382716], "unit": "score", "name": "Boyer", "value": 53.822036889332054}, {"lowerIsBetter": false, "replicates": [25125.0], "unit": "score", "name": "RegExp", "value": 36.25810945273629}, {"lowerIsBetter": false, "replicates": [628.5355122564425], "unit": "score", "name": "Splay", "value": 129.65218100000004}, {"lowerIsBetter": false, "replicates": [4906.862745098039], "unit": "score", "name": "NavierStokes", "value": 302.43356643356645}], "name": "v8_7", "value": 21237.13102308412}]} 09:51:57 INFO - RETURN: dromaeo_css: 6884.07 09:51:57 INFO - RETURN: kraken: 1519.90 09:51:57 INFO - RETURN: v8_7: 21237.13 09:51:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21237.13"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1519.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6884.07"}}} 09:51:57 INFO - Return code: 0 09:51:57 INFO - # TBPL SUCCESS # 09:51:57 INFO - Running post-action listener: _resource_record_post_action 09:51:57 INFO - Running post-run listener: _resource_record_post_run 09:51:58 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 527339520; Read time: 288; Write time: 613412 09:51:58 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 105820160; Read time: 0; Write time: 97260 09:51:58 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 350797824; Read time: 288; Write time: 380196 09:51:58 INFO - Running post-run listener: _upload_blobber_files 09:51:58 INFO - Blob upload gear active. 09:51:58 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:51:58 INFO - Copying logs to upload dir... 09:51:58 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1259.609905 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2015-11-20 09:51:58.483363) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 09:51:58.487301) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1448040511.715958-1160632041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/tBW8e_9rRTyfx6v-MFAxoA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009950 build_url: 'https://queue.taskcluster.net/v1/task/tBW8e_9rRTyfx6v-MFAxoA/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 09:51:58.542062) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 09:51:58.542397) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1448040511.715958-1160632041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004544 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 09:51:58.594274) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 09:51:58.595008) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 09:51:58.595639) ========= ========= Total master_lag: 0.25 =========