builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-061 starttime: 1447781751.85 results: success (0) buildid: 20151117073331 builduid: 7b13ee8d34ca46dbb0ba675ecbd95936 revision: f3eb66d21d1ca1e9b140a3052dda40717358562b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:51.853155) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:51.853702) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:51.854052) ========= 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=5804b9f07a53938c557deee7000001c5-1447778624.856714-1849539176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006666 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:51.876463) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:51.876814) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:51.897860) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:51.898249) ========= 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=5804b9f07a53938c557deee7000001c5-1447778624.856714-1849539176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.024115 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:51.945422) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:51.945791) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:51.946248) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:51.946580) ========= 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=5804b9f07a53938c557deee7000001c5-1447778624.856714-1849539176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-17 09:35:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2015-11-17 09:35:52 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.178152 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:52.137706) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:52.138083) ========= 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=5804b9f07a53938c557deee7000001c5-1447778624.856714-1849539176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.076130 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:52.226295) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-17 09:35:52.226704) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f3eb66d21d1ca1e9b140a3052dda40717358562b --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 f3eb66d21d1ca1e9b140a3052dda40717358562b --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=5804b9f07a53938c557deee7000001c5-1447778624.856714-1849539176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-17 09:35:52,643 truncating revision to first 12 chars 2015-11-17 09:35:52,643 Setting DEBUG logging. 2015-11-17 09:35:52,643 attempt 1/10 2015-11-17 09:35:52,643 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/f3eb66d21d1c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 09:35:53,806 unpacking tar archive at: mozilla-inbound-f3eb66d21d1c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.500907 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-17 09:35:53.745005) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:53.745508) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:53.756731) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:53.757082) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:53.757586) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2015-11-17 09:35:53.757931) ========= /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=5804b9f07a53938c557deee7000001c5-1447778624.856714-1849539176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:35:54 INFO - MultiFileLogger online at 20151117 09:35:54 in /builds/slave/test-pgo 09:35:54 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:35:54 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:35:54 INFO - {'append_to_log': False, 09:35:54 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:35:54 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 09:35:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:35:54 INFO - 'branch': 'Mozilla-Inbound', 09:35:54 INFO - 'buildbot_json_path': 'buildprops.json', 09:35:54 INFO - 'config_files': ('talos/linux_config.py',), 09:35:54 INFO - 'default_actions': ('clobber', 09:35:54 INFO - 'read-buildbot-config', 09:35:54 INFO - 'download-and-extract', 09:35:54 INFO - 'populate-webroot', 09:35:54 INFO - 'create-virtualenv', 09:35:54 INFO - 'install', 09:35:54 INFO - 'run-tests'), 09:35:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:35:54 INFO - 'download_minidump_stackwalk': True, 09:35:54 INFO - 'download_symbols': 'ondemand', 09:35:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:35:54 INFO - 'tooltool.py': '/tools/tooltool.py', 09:35:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:35:54 INFO - '/tools/misc-python/virtualenv.py')}, 09:35:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:35:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:35:54 INFO - 'installer_path': 'installer.exe', 09:35:54 INFO - 'log_level': 'info', 09:35:54 INFO - 'log_name': 'talos', 09:35:54 INFO - 'log_to_console': True, 09:35:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:35:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:35:54 INFO - 'opt_config_files': (), 09:35:54 INFO - 'pip_index': False, 09:35:54 INFO - 'sps_profile': False, 09:35:54 INFO - 'sps_profile_interval': 0, 09:35:54 INFO - 'suite': 'dromaeojs-e10s', 09:35:54 INFO - 'system_bits': '64', 09:35:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:35:54 INFO - 'title': 'talos-linux64-ix-061', 09:35:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:35:54 INFO - 'use_talos_json': True, 09:35:54 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:35:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:35:54 INFO - 'work_dir': 'build'} 09:35:54 INFO - ##### 09:35:54 INFO - ##### Running clobber step. 09:35:54 INFO - ##### 09:35:54 INFO - Running pre-action listener: _resource_record_pre_action 09:35:54 INFO - Running main action method: clobber 09:35:54 INFO - rmtree: /builds/slave/test-pgo/build 09:35:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:35:55 INFO - Running post-action listener: _resource_record_post_action 09:35:55 INFO - ##### 09:35:55 INFO - ##### Running read-buildbot-config step. 09:35:55 INFO - ##### 09:35:55 INFO - Running pre-action listener: _resource_record_pre_action 09:35:55 INFO - Running main action method: read_buildbot_config 09:35:55 INFO - Using buildbot properties: 09:35:55 INFO - { 09:35:55 INFO - "properties": { 09:35:55 INFO - "buildnumber": 195, 09:35:55 INFO - "product": "firefox", 09:35:55 INFO - "script_repo_revision": "production", 09:35:55 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 09:35:55 INFO - "repository": "", 09:35:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 09:35:55 INFO - "buildid": "20151117073331", 09:35:55 INFO - "slavename": "talos-linux64-ix-061", 09:35:55 INFO - "pgo_build": "True", 09:35:55 INFO - "basedir": "/builds/slave/test-pgo", 09:35:55 INFO - "project": "", 09:35:55 INFO - "platform": "ubuntu64_hw", 09:35:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:35:55 INFO - "slavebuilddir": "test", 09:35:55 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 09:35:55 INFO - "branch": "mozilla-inbound", 09:35:55 INFO - "repo_path": "integration/mozilla-inbound", 09:35:55 INFO - "stage_platform": "linux64-pgo", 09:35:55 INFO - "builduid": "7b13ee8d34ca46dbb0ba675ecbd95936", 09:35:55 INFO - "revision": "f3eb66d21d1ca1e9b140a3052dda40717358562b" 09:35:55 INFO - }, 09:35:55 INFO - "sourcestamp": { 09:35:55 INFO - "repository": "", 09:35:55 INFO - "hasPatch": false, 09:35:55 INFO - "project": "", 09:35:55 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 09:35:55 INFO - "changes": [ 09:35:55 INFO - { 09:35:55 INFO - "category": null, 09:35:55 INFO - "files": [ 09:35:55 INFO - { 09:35:55 INFO - "url": null, 09:35:55 INFO - "name": "https://queue.taskcluster.net/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:35:55 INFO - } 09:35:55 INFO - ], 09:35:55 INFO - "repository": "", 09:35:55 INFO - "rev": "f3eb66d21d1ca1e9b140a3052dda40717358562b", 09:35:55 INFO - "who": "sendchange", 09:35:55 INFO - "when": 1447781708, 09:35:55 INFO - "number": 6672764, 09:35:55 INFO - "comments": "", 09:35:55 INFO - "project": "", 09:35:55 INFO - "at": "Tue 17 Nov 2015 09:35:08", 09:35:55 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 09:35:55 INFO - "revlink": "", 09:35:55 INFO - "properties": [ 09:35:55 INFO - [ 09:35:55 INFO - "buildid", 09:35:55 INFO - "20151117073331", 09:35:55 INFO - "Change" 09:35:55 INFO - ], 09:35:55 INFO - [ 09:35:55 INFO - "builduid", 09:35:55 INFO - "7b13ee8d34ca46dbb0ba675ecbd95936", 09:35:55 INFO - "Change" 09:35:55 INFO - ], 09:35:55 INFO - [ 09:35:55 INFO - "pgo_build", 09:35:55 INFO - "True", 09:35:55 INFO - "Change" 09:35:55 INFO - ] 09:35:55 INFO - ], 09:35:55 INFO - "revision": "f3eb66d21d1ca1e9b140a3052dda40717358562b" 09:35:55 INFO - } 09:35:55 INFO - ], 09:35:55 INFO - "revision": "f3eb66d21d1ca1e9b140a3052dda40717358562b" 09:35:55 INFO - } 09:35:55 INFO - } 09:35:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:35:55 INFO - Running post-action listener: _resource_record_post_action 09:35:55 INFO - ##### 09:35:55 INFO - ##### Running download-and-extract step. 09:35:55 INFO - ##### 09:35:55 INFO - Running pre-action listener: _resource_record_pre_action 09:35:55 INFO - Running main action method: download_and_extract 09:35:55 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:55 INFO - https://queue.taskcluster.net/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:35:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/test_packages.json 09:35:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/test_packages.json 09:35:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:35:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:35:55 INFO - Downloaded 1302 bytes. 09:35:55 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:35:55 INFO - Using the following test package requirements: 09:35:55 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:35:55 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:55 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:35:55 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:55 INFO - u'jsshell-linux-x86_64.zip'], 09:35:55 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:55 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:35:55 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:35:55 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:55 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:35:55 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:55 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:35:55 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:55 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:35:55 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:35:55 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:55 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:35:55 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:55 INFO - https://queue.taskcluster.net/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:35:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:35:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:35:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/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:35:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/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:35:57 INFO - Downloaded 22461671 bytes. 09:35:57 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:35:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:35:57 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:35:58 INFO - Return code: 0 09:35:58 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:35:58 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:35:58 INFO - https://queue.taskcluster.net/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:35:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:35:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:35:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/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:35:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/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:35:59 INFO - Downloaded 22461671 bytes. 09:35:59 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:35:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:35:59 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:36:01 INFO - Return code: 0 09:36:01 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:36:01 INFO - https://queue.taskcluster.net/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:36:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:36:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:36:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/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:36:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/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:36:02 INFO - Downloaded 11131693 bytes. 09:36:02 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:36:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:36:02 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:36:02 INFO - Return code: 0 09:36:02 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:36:02 INFO - https://queue.taskcluster.net/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:36:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:36:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:36:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/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:36:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/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:36:03 INFO - Downloaded 57187865 bytes. 09:36:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:36:03 INFO - mkdir: /builds/slave/test-pgo/properties 09:36:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:36:03 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:36:03 INFO - Contents: 09:36:03 INFO - build_url:https://queue.taskcluster.net/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:36:03 INFO - Running post-action listener: _resource_record_post_action 09:36:03 INFO - Running post-action listener: set_extra_try_arguments 09:36:03 INFO - ##### 09:36:03 INFO - ##### Running populate-webroot step. 09:36:03 INFO - ##### 09:36:03 INFO - Running pre-action listener: _resource_record_pre_action 09:36:03 INFO - Running main action method: populate_webroot 09:36:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:36:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:36:03 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:36:03 INFO - '../fennec_ids.txt'], 09:36:03 INFO - 'tests': ['tcheck2']}, 09:36:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:36:03 INFO - '--tppagecycles', 09:36:03 INFO - '7'], 09:36:03 INFO - 'tests': ['tsvgm']}}, 09:36:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:36:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:36:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:36:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:36:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:36:03 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:36:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:36:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:03 INFO - 'talos_options': ['--e10s'], 09:36:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:36:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:03 INFO - 'tests': ['damp', 'tps']}, 09:36:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:03 INFO - 'talos_options': ['--e10s'], 09:36:03 INFO - 'tests': ['damp', 'tps']}, 09:36:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:36:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:36:03 INFO - 'other': {'tests': ['a11yr', 09:36:03 INFO - 'ts_paint', 09:36:03 INFO - 'tpaint', 09:36:03 INFO - 'sessionrestore', 09:36:03 INFO - 'sessionrestore_no_auto_restore']}, 09:36:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:36:03 INFO - 'tests': ['a11yr', 09:36:03 INFO - 'ts_paint', 09:36:03 INFO - 'tpaint', 09:36:03 INFO - 'sessionrestore', 09:36:03 INFO - 'sessionrestore_no_auto_restore']}, 09:36:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:36:03 INFO - 'tests': ['a11yr', 09:36:03 INFO - 'ts_paint', 09:36:03 INFO - 'tpaint', 09:36:03 INFO - 'sessionrestore', 09:36:03 INFO - 'sessionrestore_no_auto_restore']}, 09:36:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:36:03 INFO - 'tests': ['a11yr', 09:36:03 INFO - 'ts_paint', 09:36:03 INFO - 'tpaint', 09:36:03 INFO - 'sessionrestore', 09:36:03 INFO - 'sessionrestore_no_auto_restore']}, 09:36:03 INFO - 'other_l64': {'tests': ['a11yr', 09:36:03 INFO - 'ts_paint', 09:36:03 INFO - 'tpaint', 09:36:03 INFO - 'sessionrestore', 09:36:03 INFO - 'sessionrestore_no_auto_restore']}, 09:36:03 INFO - 'other_nol64': {'tests': ['a11yr', 09:36:03 INFO - 'ts_paint', 09:36:03 INFO - 'tpaint', 09:36:03 INFO - 'sessionrestore', 09:36:03 INFO - 'sessionrestore_no_auto_restore']}, 09:36:03 INFO - 'svgr': {'tests': ['tsvgx', 09:36:03 INFO - 'tsvgr_opacity', 09:36:03 INFO - 'tart', 09:36:03 INFO - 'tscrollx', 09:36:03 INFO - 'cart']}, 09:36:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:36:03 INFO - 'tests': ['tsvgx', 09:36:03 INFO - 'tsvgr_opacity', 09:36:03 INFO - 'tart', 09:36:03 INFO - 'tscrollx', 09:36:03 INFO - 'cart']}, 09:36:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:03 INFO - 'tests': ['tp5o']}, 09:36:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:03 INFO - 'talos_options': ['--e10s'], 09:36:03 INFO - 'tests': ['tp5o']}, 09:36:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:03 INFO - 'talos_options': ['--xperf_path', 09:36:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:36:03 INFO - 'tests': ['tp5n']}, 09:36:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:03 INFO - 'talos_options': ['--e10s', 09:36:03 INFO - '--xperf_path', 09:36:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:36:03 INFO - 'tests': ['tp5n']}}, 09:36:03 INFO - 'talos.zip': {'path': '', 09:36:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:36:03 INFO - Running post-action listener: _resource_record_post_action 09:36:03 INFO - ##### 09:36:03 INFO - ##### Running create-virtualenv step. 09:36:03 INFO - ##### 09:36:03 INFO - Running pre-action listener: _resource_record_pre_action 09:36:03 INFO - Running main action method: create_virtualenv 09:36:03 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:36:03 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:36:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:36:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:36:03 INFO - Using real prefix '/usr' 09:36:03 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:36:04 INFO - Installing distribute.............................................................................................................................................................................................done. 09:36:06 INFO - Installing pip.................done. 09:36:06 INFO - Return code: 0 09:36:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:36: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:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36: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:36:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fa890dafc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29db3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a648c0>, '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 0x2a11420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a118b0>, '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': '5804b9f07a53938c557deee7000001c5-1447778624.856714-1849539176', '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:36:06 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:36:06 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:36:06 INFO - Using env: {'DISPLAY': ':0', 09:36:06 INFO - 'HOME': '/home/cltbld', 09:36:06 INFO - 'LANG': 'en_US.UTF-8', 09:36:06 INFO - 'LANGUAGE': 'en_US:en', 09:36:06 INFO - 'LOGNAME': 'cltbld', 09:36:06 INFO - 'MAIL': '/var/mail/cltbld', 09:36:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:06 INFO - 'MOZ_NO_REMOTE': '1', 09:36:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:06 INFO - 'NO_EM_RESTART': '1', 09:36:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:36:06 INFO - 'PWD': '/builds/slave/test-pgo', 09:36:06 INFO - 'SHELL': '/bin/bash', 09:36:06 INFO - 'SHLVL': '1', 09:36:06 INFO - 'TERM': 'linux', 09:36:06 INFO - 'TMOUT': '86400', 09:36:06 INFO - 'USER': 'cltbld', 09:36:06 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447778624.856714-1849539176', 09:36:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:06 INFO - '_': '/tools/buildbot/bin/python'} 09:36:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:06 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:36:06 INFO - Cleaning up... 09:36:06 INFO - Return code: 0 09:36:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:36: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:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36: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:36:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fa890dafc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29db3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a648c0>, '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 0x2a11420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a118b0>, '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': '5804b9f07a53938c557deee7000001c5-1447778624.856714-1849539176', '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:36:06 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:36:06 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:36:06 INFO - Using env: {'DISPLAY': ':0', 09:36:06 INFO - 'HOME': '/home/cltbld', 09:36:06 INFO - 'LANG': 'en_US.UTF-8', 09:36:06 INFO - 'LANGUAGE': 'en_US:en', 09:36:06 INFO - 'LOGNAME': 'cltbld', 09:36:06 INFO - 'MAIL': '/var/mail/cltbld', 09:36:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:06 INFO - 'MOZ_NO_REMOTE': '1', 09:36:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:06 INFO - 'NO_EM_RESTART': '1', 09:36:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:36:06 INFO - 'PWD': '/builds/slave/test-pgo', 09:36:06 INFO - 'SHELL': '/bin/bash', 09:36:06 INFO - 'SHLVL': '1', 09:36:06 INFO - 'TERM': 'linux', 09:36:06 INFO - 'TMOUT': '86400', 09:36:06 INFO - 'USER': 'cltbld', 09:36:06 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447778624.856714-1849539176', 09:36:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:06 INFO - '_': '/tools/buildbot/bin/python'} 09:36:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:06 INFO - Downloading/unpacking psutil>=0.7.1 09:36:06 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:36:06 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:36:06 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:36:06 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:36:06 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:36:06 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:36:08 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 09:36:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:36:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:36:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:36:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:36:08 INFO - Installing collected packages: psutil 09:36:08 INFO - Running setup.py install for psutil 09:36:08 INFO - building 'psutil._psutil_linux' extension 09:36:08 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:36:08 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:36:08 INFO - building 'psutil._psutil_posix' extension 09:36:08 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:36:08 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:36:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:36:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:36:08 INFO - Successfully installed psutil 09:36:08 INFO - Cleaning up... 09:36:08 INFO - Return code: 0 09:36:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:08 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 0x7fa890dafc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29db3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a648c0>, '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 0x2a11420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a118b0>, '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': '5804b9f07a53938c557deee7000001c5-1447778624.856714-1849539176', '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:36:08 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:36:08 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:36:08 INFO - Using env: {'DISPLAY': ':0', 09:36:08 INFO - 'HOME': '/home/cltbld', 09:36:08 INFO - 'LANG': 'en_US.UTF-8', 09:36:08 INFO - 'LANGUAGE': 'en_US:en', 09:36:08 INFO - 'LOGNAME': 'cltbld', 09:36:08 INFO - 'MAIL': '/var/mail/cltbld', 09:36:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:08 INFO - 'MOZ_NO_REMOTE': '1', 09:36:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:08 INFO - 'NO_EM_RESTART': '1', 09:36:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:36:08 INFO - 'PWD': '/builds/slave/test-pgo', 09:36:08 INFO - 'SHELL': '/bin/bash', 09:36:08 INFO - 'SHLVL': '1', 09:36:08 INFO - 'TERM': 'linux', 09:36:08 INFO - 'TMOUT': '86400', 09:36:08 INFO - 'USER': 'cltbld', 09:36:08 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447778624.856714-1849539176', 09:36:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:08 INFO - '_': '/tools/buildbot/bin/python'} 09:36:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:36:09 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:36:09 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:36:09 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:36:09 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:36:09 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:36:09 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:36:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:36:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:36:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:36:10 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:36:10 INFO - Installing collected packages: mozsystemmonitor 09:36:10 INFO - Running setup.py install for mozsystemmonitor 09:36:10 INFO - Successfully installed mozsystemmonitor 09:36:10 INFO - Cleaning up... 09:36:11 INFO - Return code: 0 09:36:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:36:11 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:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:11 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:36:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:11 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 0x7fa890dafc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29db3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a648c0>, '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 0x2a11420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a118b0>, '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': '5804b9f07a53938c557deee7000001c5-1447778624.856714-1849539176', '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:36:11 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:36:11 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:36:11 INFO - Using env: {'DISPLAY': ':0', 09:36:11 INFO - 'HOME': '/home/cltbld', 09:36:11 INFO - 'LANG': 'en_US.UTF-8', 09:36:11 INFO - 'LANGUAGE': 'en_US:en', 09:36:11 INFO - 'LOGNAME': 'cltbld', 09:36:11 INFO - 'MAIL': '/var/mail/cltbld', 09:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:11 INFO - 'MOZ_NO_REMOTE': '1', 09:36:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:11 INFO - 'NO_EM_RESTART': '1', 09:36:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:36:11 INFO - 'PWD': '/builds/slave/test-pgo', 09:36:11 INFO - 'SHELL': '/bin/bash', 09:36:11 INFO - 'SHLVL': '1', 09:36:11 INFO - 'TERM': 'linux', 09:36:11 INFO - 'TMOUT': '86400', 09:36:11 INFO - 'USER': 'cltbld', 09:36:11 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447778624.856714-1849539176', 09:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:11 INFO - '_': '/tools/buildbot/bin/python'} 09:36:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:11 INFO - Downloading/unpacking blobuploader==1.2.4 09:36:11 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:36:11 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:36:11 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:36:11 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:36:11 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:36:11 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:36:12 INFO - Downloading blobuploader-1.2.4.tar.gz 09:36:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:36:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:36:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:36:12 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:36:12 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:36:12 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:36:12 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:36:12 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:36:12 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:36:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:36:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:36:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:13 INFO - Downloading docopt-0.6.1.tar.gz 09:36:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:36:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:36:13 INFO - Installing collected packages: blobuploader, requests, docopt 09:36:13 INFO - Running setup.py install for blobuploader 09:36:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:36:13 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:36:13 INFO - Running setup.py install for requests 09:36:14 INFO - Running setup.py install for docopt 09:36:14 INFO - Successfully installed blobuploader requests docopt 09:36:14 INFO - Cleaning up... 09:36:14 INFO - Return code: 0 09:36:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:36: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:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36: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:36:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:14 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 0x7fa890dafc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29db3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a648c0>, '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 0x2a11420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a118b0>, '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': '5804b9f07a53938c557deee7000001c5-1447778624.856714-1849539176', '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:36:14 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:36:14 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:36:14 INFO - Using env: {'DISPLAY': ':0', 09:36:14 INFO - 'HOME': '/home/cltbld', 09:36:14 INFO - 'LANG': 'en_US.UTF-8', 09:36:14 INFO - 'LANGUAGE': 'en_US:en', 09:36:14 INFO - 'LOGNAME': 'cltbld', 09:36:14 INFO - 'MAIL': '/var/mail/cltbld', 09:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:14 INFO - 'MOZ_NO_REMOTE': '1', 09:36:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:14 INFO - 'NO_EM_RESTART': '1', 09:36:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:36:14 INFO - 'PWD': '/builds/slave/test-pgo', 09:36:14 INFO - 'SHELL': '/bin/bash', 09:36:14 INFO - 'SHLVL': '1', 09:36:14 INFO - 'TERM': 'linux', 09:36:14 INFO - 'TMOUT': '86400', 09:36:14 INFO - 'USER': 'cltbld', 09:36:14 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447778624.856714-1849539176', 09:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:14 INFO - '_': '/tools/buildbot/bin/python'} 09:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:36:14 INFO - Running setup.py (path:/tmp/pip-k0t1D4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:36:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:36:14 INFO - Running setup.py (path:/tmp/pip-W98pmG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:36:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:36:14 INFO - Running setup.py (path:/tmp/pip-rlWnEd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:36:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:36:14 INFO - Running setup.py (path:/tmp/pip-en0Yjx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:36:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:36:14 INFO - Running setup.py (path:/tmp/pip-_TJNxA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:36:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:36:14 INFO - Running setup.py (path:/tmp/pip-_IAeBo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:36:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:36:14 INFO - Running setup.py (path:/tmp/pip-zlOZru-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:36:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:36:14 INFO - Running setup.py (path:/tmp/pip-Iu5PHZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:36:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:36:14 INFO - Running setup.py (path:/tmp/pip-KDgKR8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:36:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:36:15 INFO - Running setup.py (path:/tmp/pip-W23eJR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:36:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:36:15 INFO - Running setup.py (path:/tmp/pip-M8cuMS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:36:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:36:15 INFO - Running setup.py (path:/tmp/pip-P_Brp0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:36:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:36:15 INFO - Running setup.py (path:/tmp/pip-_nK1ui-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:36:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:36:15 INFO - Running setup.py (path:/tmp/pip-oqwYeG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:36:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:36:15 INFO - Running setup.py (path:/tmp/pip-bwG1Nf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:36:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:36:15 INFO - Running setup.py (path:/tmp/pip-uu7c9u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:36:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:36:15 INFO - Running setup.py (path:/tmp/pip-ICq8OH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:36:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:36:15 INFO - Running setup.py install for manifestparser 09:36:15 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:36:15 INFO - Running setup.py install for mozcrash 09:36:15 INFO - Running setup.py install for mozdebug 09:36:15 INFO - Running setup.py install for mozdevice 09:36:16 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:36:16 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:36:16 INFO - Running setup.py install for mozfile 09:36:16 INFO - Running setup.py install for mozhttpd 09:36:16 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:36:16 INFO - Running setup.py install for mozinfo 09:36:16 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:36:16 INFO - Running setup.py install for mozInstall 09:36:16 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:36:16 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:36:16 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:36:16 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:36:16 INFO - Running setup.py install for mozleak 09:36:16 INFO - Running setup.py install for mozlog 09:36:16 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:36:16 INFO - Running setup.py install for moznetwork 09:36:16 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:36:16 INFO - Running setup.py install for mozprocess 09:36:16 INFO - Running setup.py install for mozprofile 09:36:16 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:36:16 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:36:16 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:36:16 INFO - Running setup.py install for mozrunner 09:36:17 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:36:17 INFO - Running setup.py install for mozscreenshot 09:36:17 INFO - Running setup.py install for moztest 09:36:17 INFO - Running setup.py install for mozversion 09:36:17 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:36:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:36:17 INFO - Cleaning up... 09:36:17 INFO - Return code: 0 09:36:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:36: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:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36: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:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36: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', '-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 0x7fa890dafc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29db3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a648c0>, '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 0x2a11420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a118b0>, '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': '5804b9f07a53938c557deee7000001c5-1447778624.856714-1849539176', '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:36:17 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:36:17 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:36:17 INFO - Using env: {'DISPLAY': ':0', 09:36:17 INFO - 'HOME': '/home/cltbld', 09:36:17 INFO - 'LANG': 'en_US.UTF-8', 09:36:17 INFO - 'LANGUAGE': 'en_US:en', 09:36:17 INFO - 'LOGNAME': 'cltbld', 09:36:17 INFO - 'MAIL': '/var/mail/cltbld', 09:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:17 INFO - 'MOZ_NO_REMOTE': '1', 09:36:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:17 INFO - 'NO_EM_RESTART': '1', 09:36:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:36:17 INFO - 'PWD': '/builds/slave/test-pgo', 09:36:17 INFO - 'SHELL': '/bin/bash', 09:36:17 INFO - 'SHLVL': '1', 09:36:17 INFO - 'TERM': 'linux', 09:36:17 INFO - 'TMOUT': '86400', 09:36:17 INFO - 'USER': 'cltbld', 09:36:17 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447778624.856714-1849539176', 09:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:17 INFO - '_': '/tools/buildbot/bin/python'} 09:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:36:17 INFO - Running setup.py (path:/tmp/pip-e3C9du-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:36:17 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:36:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:36:17 INFO - Running setup.py (path:/tmp/pip-Q3xL75-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:36:17 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:36:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:36:17 INFO - Running setup.py (path:/tmp/pip-jRfXrH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:36:17 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:36:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:36:17 INFO - Running setup.py (path:/tmp/pip-hTaCx2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:36:17 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:36:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:36:17 INFO - Running setup.py (path:/tmp/pip-AW4tht-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:36:17 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:36:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:36:17 INFO - Running setup.py (path:/tmp/pip-MMm9Pf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:36:18 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:36:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:36:18 INFO - Running setup.py (path:/tmp/pip-1oymSq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:36:18 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:36:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:36:18 INFO - Running setup.py (path:/tmp/pip-gIgsP3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:36:18 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:36:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:36:18 INFO - Running setup.py (path:/tmp/pip-hoHJs3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:36:18 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:36:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:36:18 INFO - Running setup.py (path:/tmp/pip-NJMivh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:36:18 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:36:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:36:18 INFO - Running setup.py (path:/tmp/pip-bl1jgR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:36:18 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:36:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:36:18 INFO - Running setup.py (path:/tmp/pip-ignjCX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:36:18 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:36:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:36:18 INFO - Running setup.py (path:/tmp/pip-gTREXJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:36:18 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:36:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:36:18 INFO - Running setup.py (path:/tmp/pip-9HNGZb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:36:18 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:36:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:36:18 INFO - Running setup.py (path:/tmp/pip-RkeUC3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:36:18 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:36:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:36:18 INFO - Running setup.py (path:/tmp/pip-J3ElB5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:36:18 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:36:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:36:18 INFO - Running setup.py (path:/tmp/pip-U56G8j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:36:18 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:36:18 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:36:18 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:36:18 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:36:18 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:36:18 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:36:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:36:18 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:36:18 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:36:18 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:36:18 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:36:18 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:36:18 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:36:20 INFO - Downloading blessings-1.5.1.tar.gz 09:36:20 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:36:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:36:20 INFO - Installing collected packages: blessings 09:36:20 INFO - Running setup.py install for blessings 09:36:20 INFO - Successfully installed blessings 09:36:20 INFO - Cleaning up... 09:36:20 INFO - Return code: 0 09:36:20 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:36:20 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:36:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:36:20 INFO - Reading from file tmpfile_stdout 09:36:20 INFO - Current package versions: 09:36:20 INFO - argparse == 1.2.1 09:36:20 INFO - blessings == 1.5.1 09:36:20 INFO - blobuploader == 1.2.4 09:36:20 INFO - docopt == 0.6.1 09:36:20 INFO - manifestparser == 1.1 09:36:20 INFO - mozInstall == 1.12 09:36:20 INFO - mozcrash == 0.16 09:36:20 INFO - mozdebug == 0.1 09:36:20 INFO - mozdevice == 0.47 09:36:20 INFO - mozfile == 1.2 09:36:20 INFO - mozhttpd == 0.7 09:36:20 INFO - mozinfo == 0.9 09:36:20 INFO - mozleak == 0.1 09:36:20 INFO - mozlog == 3.0 09:36:20 INFO - moznetwork == 0.27 09:36:20 INFO - mozprocess == 0.22 09:36:20 INFO - mozprofile == 0.27 09:36:20 INFO - mozrunner == 6.11 09:36:20 INFO - mozscreenshot == 0.1 09:36:20 INFO - mozsystemmonitor == 0.0 09:36:20 INFO - moztest == 0.7 09:36:20 INFO - mozversion == 1.4 09:36:20 INFO - psutil == 3.1.1 09:36:20 INFO - requests == 1.2.3 09:36:20 INFO - wsgiref == 0.1.2 09:36:20 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:36:20 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:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:20 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:36:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:20 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 0x7fa890dafc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29db3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a648c0>, '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 0x2a11420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a118b0>, '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': '5804b9f07a53938c557deee7000001c5-1447778624.856714-1849539176', '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:36:20 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:36:20 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:36:20 INFO - Using env: {'DISPLAY': ':0', 09:36:20 INFO - 'HOME': '/home/cltbld', 09:36:20 INFO - 'LANG': 'en_US.UTF-8', 09:36:20 INFO - 'LANGUAGE': 'en_US:en', 09:36:20 INFO - 'LOGNAME': 'cltbld', 09:36:20 INFO - 'MAIL': '/var/mail/cltbld', 09:36:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:20 INFO - 'MOZ_NO_REMOTE': '1', 09:36:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:20 INFO - 'NO_EM_RESTART': '1', 09:36:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:36:20 INFO - 'PWD': '/builds/slave/test-pgo', 09:36:20 INFO - 'SHELL': '/bin/bash', 09:36:20 INFO - 'SHLVL': '1', 09:36:20 INFO - 'TERM': 'linux', 09:36:20 INFO - 'TMOUT': '86400', 09:36:20 INFO - 'USER': 'cltbld', 09:36:20 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447778624.856714-1849539176', 09:36:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:20 INFO - '_': '/tools/buildbot/bin/python'} 09:36:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:21 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:36:21 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:36:21 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:36:21 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:36:21 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:36:21 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:36:21 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:36:21 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:36:21 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:36:21 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:36:21 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:36:21 INFO - Cleaning up... 09:36:21 INFO - Return code: 0 09:36:21 INFO - Running post-action listener: _resource_record_post_action 09:36:21 INFO - Running post-action listener: _start_resource_monitoring 09:36:21 INFO - Starting resource monitoring. 09:36:21 INFO - ##### 09:36:21 INFO - ##### Running install step. 09:36:21 INFO - ##### 09:36:21 INFO - Running pre-action listener: _resource_record_pre_action 09:36:21 INFO - Running main action method: install 09:36:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:36:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:36:21 INFO - Reading from file tmpfile_stdout 09:36:21 INFO - Detecting whether we're running mozinstall >=1.0... 09:36:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:36:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:36:21 INFO - Reading from file tmpfile_stdout 09:36:21 INFO - Output received: 09:36:21 INFO - Usage: mozinstall [options] installer 09:36:21 INFO - Options: 09:36:21 INFO - -h, --help show this help message and exit 09:36:21 INFO - -d DEST, --destination=DEST 09:36:21 INFO - Directory to install application into. [default: 09:36:21 INFO - "/builds/slave/test-pgo"] 09:36:21 INFO - --app=APP Application being installed. [default: firefox] 09:36:21 INFO - mkdir: /builds/slave/test-pgo/build/application 09:36:21 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:36:21 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:36:35 INFO - Reading from file tmpfile_stdout 09:36:35 INFO - Output received: 09:36:35 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:36:35 INFO - Running post-action listener: _resource_record_post_action 09:36:35 INFO - ##### 09:36:35 INFO - ##### Running run-tests step. 09:36:35 INFO - ##### 09:36:35 INFO - Running pre-action listener: _resource_record_pre_action 09:36:35 INFO - Running main action method: run_tests 09:36:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:36:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:36:35 INFO - Python 2.7.3 09:36:35 INFO - Return code: 0 09:36:35 INFO - grabbing minidump binary from tooltool 09:36:35 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:36:35 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 0x2a648c0>, '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 0x2a11420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a118b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:36:35 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:36:35 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:36:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:36:35 INFO - Return code: 0 09:36:35 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:36:35 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:36:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:36:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:36:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:36:35 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/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 09:36:35 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/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost 09:36:35 INFO - Using env: {'DISPLAY': ':0', 09:36:35 INFO - 'HOME': '/home/cltbld', 09:36:35 INFO - 'LANG': 'en_US.UTF-8', 09:36:35 INFO - 'LANGUAGE': 'en_US:en', 09:36:35 INFO - 'LOGNAME': 'cltbld', 09:36:35 INFO - 'MAIL': '/var/mail/cltbld', 09:36:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:36:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:35 INFO - 'MOZ_NO_REMOTE': '1', 09:36:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:35 INFO - 'NO_EM_RESTART': '1', 09:36:35 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:36:35 INFO - 'PWD': '/builds/slave/test-pgo', 09:36:35 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:36:35 INFO - 'SHELL': '/bin/bash', 09:36:35 INFO - 'SHLVL': '1', 09:36:35 INFO - 'TERM': 'linux', 09:36:35 INFO - 'TMOUT': '86400', 09:36:35 INFO - 'USER': 'cltbld', 09:36:35 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447778624.856714-1849539176', 09:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:35 INFO - '_': '/tools/buildbot/bin/python'} 09:36:35 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/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost'] with output_timeout 3600 09:36:36 INFO - mozversion INFO | application_buildid: 20151117073331 09:36:36 INFO - mozversion INFO | application_changeset: f3eb66d21d1ca1e9b140a3052dda40717358562b 09:36:36 INFO - mozversion INFO | application_display_name: Nightly 09:36:36 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:36:36 INFO - mozversion INFO | application_name: Firefox 09:36:36 INFO - mozversion INFO | application_remotingname: firefox 09:36:36 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:36:36 INFO - mozversion INFO | application_vendor: Mozilla 09:36:36 INFO - mozversion INFO | application_version: 45.0a1 09:36:36 INFO - mozversion INFO | platform_buildid: 20151117073331 09:36:36 INFO - mozversion INFO | platform_changeset: f3eb66d21d1ca1e9b140a3052dda40717358562b 09:36:36 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:36:36 INFO - mozversion INFO | platform_version: 45.0a1 09:36:36 INFO - 2015-11-17 09:36:36,104 DEBUG : using testdate: 1447781796 09:36:36 INFO - 2015-11-17 09:36:36,104 DEBUG : actual date: 1447781796 09:36:36 INFO - 2015-11-17 09:36:36,151 INFO : starting webserver on 'localhost:50867' 09:36:36 INFO - 2015-11-17 09:36:36,152 INFO : Starting test suite talos-linux64-ix-061.e 09:36:36 INFO - 2015-11-17 09:36:36,152 INFO : Starting test dromaeo_css 09:36:36 INFO - 2015-11-17 09:36:36,152 DEBUG : operating with platform_type : linux_ 09:36:36 INFO - 2015-11-17 09:36:36,153 INFO : Initialising browser for dromaeo_css test... 09:36:36 INFO - 2015-11-17 09:36:36,162 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUviSiN/profile http://localhost:50867/getInfo.html 09:36:40 INFO - 2015-11-17 09:36:40,750 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:36:40 INFO - 2015-11-17 09:36:40,750 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:36:40 INFO - 2015-11-17 09:36:40,750 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:36:40 INFO - 2015-11-17 09:36:40,750 DEBUG : BROWSER_OUTPUT: __metrics 09:36:41 INFO - 2015-11-17 09:36:41,741 INFO : Browser initialized. 09:36:41 INFO - 2015-11-17 09:36:41,742 INFO : Running cycle 1/1 for dromaeo_css test... 09:36:41 INFO - 2015-11-17 09:36:41,742 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUviSiN/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:36:53 INFO - 2015-11-17 09:36:53,556 DEBUG : BROWSER_OUTPUT: RSS: Main: 139915264 09:36:53 INFO - 2015-11-17 09:36:53,556 DEBUG : BROWSER_OUTPUT: 09:37:43 INFO - 2015-11-17 09:37:43,163 DEBUG : BROWSER_OUTPUT: 1447781863162 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:39:52 INFO - 2015-11-17 09:39:52,143 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50867/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50867/tests/dromaeo/cssquery-ext.html) 09:39:53 INFO - 2015-11-17 09:39:53,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 147259392 09:39:53 INFO - 2015-11-17 09:39:53,229 DEBUG : BROWSER_OUTPUT: 09:42:55 INFO - 2015-11-17 09:42:55,122 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50867/tests/dromaeo/cssquery-ext.html (next: http://localhost:50867/tests/dromaeo/cssquery-jquery.html) 09:42:55 INFO - 2015-11-17 09:42:55,705 DEBUG : BROWSER_OUTPUT: RSS: Main: 141537280 09:42:55 INFO - 2015-11-17 09:42:55,706 DEBUG : BROWSER_OUTPUT: 09:45:57 INFO - 2015-11-17 09:45:57,343 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50867/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50867/tests/dromaeo/cssquery-mootools.html) 09:45:57 INFO - 2015-11-17 09:45:57,924 DEBUG : BROWSER_OUTPUT: RSS: Main: 141242368 09:45:57 INFO - 2015-11-17 09:45:57,925 DEBUG : BROWSER_OUTPUT: 09:48:59 INFO - 2015-11-17 09:48:59,596 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50867/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50867/tests/dromaeo/cssquery-prototype.html) 09:49:00 INFO - 2015-11-17 09:49:00,218 DEBUG : BROWSER_OUTPUT: RSS: Main: 140992512 09:49:00 INFO - 2015-11-17 09:49:00,218 DEBUG : BROWSER_OUTPUT: 09:52:02 INFO - 2015-11-17 09:52:02,488 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50867/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50867/tests/dromaeo/cssquery-yui.html) 09:52:03 INFO - 2015-11-17 09:52:03,095 DEBUG : BROWSER_OUTPUT: RSS: Main: 141369344 09:52:03 INFO - 2015-11-17 09:52:03,096 DEBUG : BROWSER_OUTPUT: 09:55:05 INFO - 2015-11-17 09:55:05,243 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50867/tests/dromaeo/cssquery-yui.html (next: http://localhost:50867/tests/dromaeo/cssquery-dojo.html) 09:55:05 INFO - 2015-11-17 09:55:05,501 DEBUG : BROWSER_OUTPUT: RSS: Main: 143667200 09:55:05 INFO - 2015-11-17 09:55:05,501 DEBUG : BROWSER_OUTPUT: 09:55:05 INFO - 2015-11-17 09:55:05,501 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:55:05 INFO - 2015-11-17 09:55:05,501 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:55:05 INFO - 2015-11-17 09:55:05,501 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:55:05 INFO - 2015-11-17 09:55:05,501 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:55:05 INFO - 2015-11-17 09:55:05,501 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3204.9839750801243;3284.458064419371;3289.8848540301096;3306.470964645657;3328.400887840189;5260.316158899338;5432.0493913565115;5432.619716619838;5447.836564903055;5485.753141108649;5393.568514518839;5417.972910135453;5418.943306055321;5528.944710552893;5560.304961879765;4943.431505376882;5058.0895438821;5118.129917913963;5125.256837758523;5138;5094.083065048289;5111.897762044757;5168.9224661630105;5195.194744814541;5195.688258704471;4914.70511769295;5026.824061157842;5130.640855140142;5174.844754657385;5201;4826.734529600871;4920.237363208708;4942.456329803718;4951.876203094916;4955.950440495621;5007.674501157413;5041.067402530543;5042.974785126051;5074.467180945984;5097.388313402378;5154.252633368178;5306.893862122736;5395.568354531628;5398.163284690879;5433.565314774809;5866.530677545828;5985.4912332451795;5986.07215881539;6009.06859436788;6046.09308603713;6064.423879731418;6085.026395776698;6085.934961381785;6087.239095113111;6087.817365479043;5393.838184854421;5512.062949298629;5540.445955404468;5598.608097433182;5662.6036177467595;5983.700814959235;6077.453029227391;6081.8479538011015;6082.148499210114;6128.877422451526;5863.706814659336;5876.588638795243;5900.527957763368;5934.910976335358;5939.851503712355;5829.650220986669;5953.077273022688;5981.820545383645;6018.277806663141;6027.36712645166;5864.38423965486;5955.3151387590115;5976.372480889531;5981.970090149522;5987.401259873977;5924.318703349084;6023.849403764941;6028.788992385245;6035.1249068885645;6037.973544497446;4639.466461356988;4640.396748422683;4643.883902902455;4644.535546445329;4686.74222917736;3987.342088555356;4013.5986401359633;4089.7137200396282;4119.114390406077;4154.626083652425;5538.280023596906;5549.694766787785;5552.41699621542;5609.298837645294;5676.971615141898;5915.585908986416;5918.911216331759;5927.585069045125;5956.404359564009;5979.0433530635755;5398.46015398457;5480.232767412565;5720.713964301768;5804.187413762077;5868.383819698955;5068.138416469209;5099.107656160157;5118.513741194581;5131.307273518028;5143.794248230104;6012.87974240504;6031.879362412815;6047.0627052806885;6047.9770284551405;6075.362086980892;5918.496927761188;6022.48808851235;6039.516838652985;6068.575199735976;6097.695115244132;5969.403059694169;6113.358097399887;6156.907646385397;6166.1983942087245;6174.228221472316;5794.072948328248;5974.671393073423;5975.014122669884;5981.491573216152;5989.64062156272;5913.172155898264;5969.76120955157;6027.698615069141;6034.275886893601;6060.909086363797;5849.970750146222;5894.38108998549;5914.645121292736;5924.644521328734;5924.644521328734;5723.713814309184;5768.423157684198;5891;5920.911186332295;5935.109733540004;5752.654840709571;5808.070708686759;5861.794837180678;5874.706264686834;5910.822675319747;5833.883322333614;5877.647341159544;5882.764689412375;5883.823485295448;5924.4667979882015;5615.494605485526;5645.237892884408;5713.371529131875;5771;5815.5929084963645 09:55:05 INFO - 2015-11-17 09:55:05,502 DEBUG : BROWSER_OUTPUT: |1;ext.html;552.7593469726785;584.2142318581506;588.2911092133978;594.5422025040716;598.3806760003396;37038.44442333364;37299.25401491975;37834.81082594583;37838.99999999996;37859;39833.800830995875;39885.202295954135;40318.39522407166;40412.393814092815;40470.7976460118;8870.334724895627;8991.3256505762;9061.728148155533;9073.59168837404;9074.954625226865;8763.07987661296;8825.558722063903;8834.11658834118;8867.955660221689;8871.290296776275;8897.110288971084;8918.732438026836;8937.150970657776;8962.417442866226;9000.684976025841;8811.427257228259;8909.599068041922;8917.55412229386;8945.15021072997;9010.549472526413;8782.60478278479;8804.559772011438;8864.734057978207;8883.11168883113;8887.73336799897;40793;40830.38754418686;41264.174716505804;41305;41404.79297603523;3248.3340915112344;3273.508973653947;3273.836308184605;3287.375398674244;3296.2748195396975;29854;30446.84776576103;30510.54234186489;30644.38711225763;31170.376592468252;3540.8760693375866;3586.300671369058;3604.297162053401;3611.223586928823;3709.4992176056157;251977;254157;254716;255380;256239.71880140668;59455;59763.40236597578;59794.70102649546;59857.70071149617;59923;66906.66546667332;67671;67871.66064169747;68113;68175;16199.676006479804;16362.181890905407;16460.6707865842;16492.42276520316;16526.6694666106;11866.466009029615;11968.222065565711;11994.580189693494;12000.699982500333;12061.819072713917;20851.478713031993;21131.26040588572;21259.46851328698;21287.467813304793;21294.467638309165;8304.6678132874;8526.78683032929;8591.785205369915;8592.355573332025;8666.78333041679;946.4557879219476;1007.2093406675724;1063.7021633942509;1064.9882611519088;1129.8474705914762;29375.17950343173;29759.85120074386;30113.247168820955;33048.50427243593;33365;1012.2357619996856;1024.99487502562;1062.2829590026702;1089.629525961161;1120.4061847220985;14289.56699795223;14428.350724217435;14636.487722929647;14784.186869722269;14891.255437228096;723514;740987;744767;745080;748176;55848.72075639596;56371.15443268354;56518.43481565214;56598;56613;1351.6147897849066;1354.5597680753795;1361.8978576606794;1368.2406264523286;1372.6390608153959;29765;30460;30659.313737743745;31221;31340.373192535564;47569.52430475789;47702.76148619235;47940.520594793605;48278.27582586334;48322;308349;308822;309890;310154;311571;33845.15387115243;46752.7662361686;46927.29609055799;47474.28788568105;47566.76216618895;43201.78399107984;43939.56060439355;44045;44047.11905761803;44109.77945110254;37138.81430592938;37151.07122321964;39628;40791.1841763169;43297.7835110835;39889.601103988585;40053.39919901145;40749;41145.1770964585;41982.160356793305;39485.80257098696;39611.80194099011;39834.60165398309;39891.20217595574;40084;38815.223695526496;39870.60129398669;40231.798841005606;40388;40809.183816324105;26826.731732682423;27405.86297068502;27412;27440.683013998132;27491.587626185225 09:55:05 INFO - 2015-11-17 09:55:05,502 DEBUG : BROWSER_OUTPUT: |2;jquery.html;357.07339454116567;358.0904502563489;360.61234173263733;361.79377754679825;361.86068363679976;12645.304508252066;13094.47622095115;16986.83013169868;17649.382271620496;18931.33740319089;11870.940645296761;11876.228045177057;11935.701607459818;12443.506779186488;12692.93653531731;4509.751963641998;4510.594046535811;4603.171429142753;4613.100445413146;4617.953820461786;4620.630349572043;4659.231226847566;4662.160811054009;4662.207424737802;4670.579647831694;4603.907921841561;4618.399608050949;4625.629949604024;4683.812647494096;4810.68730532516;4742.95257047432;4750;4775.904481910342;4801.351817504645;4811.639127065467;4139.2963196256405;4180.393842892794;4225.176090662322;4234.047339348653;4249.553796851317;13374.732505349839;13399.933000334935;13553.457861685521;13743.106698064594;13895;1951.2585217617357;2001.4295925661263;2035.6437623415843;2054.681524363726;2150.0754675489534;10109.938456462112;10167.084962353423;10264.74338141545;10425.113865321457;10440.32137911041;1723.1987125986477;1739.5042412912385;1747.1788259518132;1753.8509226715744;1768.9027103509302;59497.40502594962;60922;61190.38809611891;62079;62344.68827655878;6865.27914568973;7008.649567521604;7159.498835081598;7201.927980720126;7242.239564845615;8523.445976011664;8565.871511927326;8568.614412351459;8580.227779499875;8632.309415246891;5542.889142217133;5545.805896793593;5584.4136365681015;5600.103983362643;5612.438756124355;5718.399568045378;5733.426657334233;5914.9112763308585;5948.226730525091;5960.195373624592;3320.9169770755925;3359.093044877918;3361.2941282330494;3365.848536815849;3381.4420620597816;1200.0459634590522;1208.4018410886667;1208.9697757556132;1209.5101483899034;1229.6495498782804;421.3637407514675;452.3937923182951;452.5723191583987;460.0775445232355;470.9434867815884;11066.336019838835;11356.48895799691;11364.147688923364;11542;11658.125640576991;432.77711978331183;438.3599944081613;442.2592158135111;449.3484447551064;452.6763364194551;6097.878042439126;6258.90606160255;6265.937340626535;6354.936450635527;6367.554271200971;536074;541519;547148;547572;561050;74511;79902.6004869972;81168.18831811725;81524;82132.58933705294;517.9922301165485;525.5138996428288;527.9181726832347;528.9471052894756;532.8108521474899;11583.247088939192;11597.768044638891;11605.361705106301;11653;11782;35613.82193089018;37043.444348334255;37426.25147497089;37575.060623484635;38432.03919902025;44876;45998;47843;48664.75667621639;48767.26849097337;6710.932890671226;6896.310368963063;6930.653467326512;7190.89213661785;7213.495055346076;12740.4266807992;12869.2921889297;12918.935405322913;13087.214767114003;13207.273599952096;10607.628732994308;11038.558457661604;11082.61210857616;11195.10439164881;11423.543058277575;10267.486625668836;10525.9473702631;10603.628872989408;10692.732681683021;11019.669409917715;11011.119110470983;11012.017836789455;11155.386453745123;11159.665210043388;11207.327560346404;6844.828879278058;6889.931100689129;6946.409555187865;6957.2694867038235;6996.230414654282;10492.265541412027;10864;11009.339439633648;11202.327860328407;11277.379744114152 09:55:05 INFO - 2015-11-17 09:55:05,502 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1456.563031090673;1491.1276903011737;1615;1641.5567796694893;1749.1341785816014;7492.438067144965;7665.8850117248285;7802.882956755653;7897.170797066305;7902.170272121423;7995.44031917766;8057.073436554798;8141.470804397725;8153.143919888415;8154.347652187826;2239;2246.1015593762545;2253.8985745641485;2265.6261716816707;2266.841321107523;2283.4519715268384;2283.942901427469;2322.477442575424;2328.080408238745;2335.544568809083;1945.5622484940916;1977.5945931084166;2221.7778222177735;2228.0642130305228;2254.391314345126;2143.753468351144;2176.4014895903515;2177.0747432341273;2177.912883484659;2185.0713446785053;2287.451011757183;2288.5308511755215;2306.238941149417;2314.4445333120098;2316.224064938248;7740.690372385098;7773.805654858617;7840.960795196044;7845.607719613997;7846.960765196194;4625.098105869357;4714.504976977437;4734.692245004064;4737.976310118427;4765.594924431428;3046.573479712842;3107.9689203107905;3158.384115097557;3173.428782819092;3194.2333839878493;1035.9637412690595;1042.713253855196;1063.500154927183;1063.622414043019;1073.0342691577564;10852.837207441815;10923.617673381394;10935.125189984783;10961.671149865517;10984.560617575287;4134.751914885116;4136.544980052192;4152.211079894811;4178.749275043447;4199.895002624898;8733.563321833883;8758.386912916161;8782.077881822444;8797.38418310712;8809.251213646783;4562.954370456319;4585.380973568593;4591.770411479412;4596.931046034312;4608.170529304691;4261.97869010653;4313.633341166036;4320.481542214954;4321.308590625547;4327.502337231196;3414.6756058174433;3430.382531144418;3442.1738782691973;3449.379111759857;3459.930801383958;1052.8473371361263;1077.9137668986461;1084.6366467233408;1100.2023532938556;1105.922585419029;1027.1269420992246;1027.6505987963978;1070.3791800755544;1279.5073896549895;1316.9078164528582;6913;7061.576305421691;7082.752103676346;7097.503174777819;7106.822329441702;1123.80333441649;1126.3523474002482;1130.0846314485293;1141.3494308244221;1163.6160067177811;5910.9655810233035;5926.703664816742;5936.495397891142;5981.132735753292;5988.550858685616;9193.68717390124;9429.717108486757;9444.433333999981;9477.763055923657;9622.855657165148;9455.763605909908;9482;9498.050194980586;9511.762205944768;9531.761705957406;6603.438707709803;6682.63245521501;6687;6717.966410167918;7350.448716346295;7071.328223818729;7135.357817796424;7163.820904477429;7178.138623365021;7191.0292110564405;8072.112067672669;8188.672453101809;8361.95819020901;8408.2432581068;8532.914670853212;8333.541655209021;8532.786680333042;8595.18345757152;8610.870836937325;8657.480551166951;7068.222495525385;7143;7153.928460715326;7184.533005354635;7188.784336469915;7678.1170165431695;7709.190534993745;7712.652930618024;7743.264389882952;7760.728374506865;6478.255000674794;6890.069840571458;6932.272111428228;6956.930430695628;6969.825754356181;6709.496787740842;6713.1944166700305;7002.929970700432;7052.823679408056;7157.1769246537315;7095.325944035309;7153.427725781821;7198.964005179941;7201.063861697946;7210.96394518024;6209.316975132641;6436;6439.388258115471;6451.935480645321;6458;6623.172103487064;6651.102101216467;6683.899741503784;6685.264620891795;6705.865882682221 09:55:05 INFO - 2015-11-17 09:55:05,502 DEBUG : BROWSER_OUTPUT: |4;prototype.html;330.47124600638966;332.29884942770764;337.84627994262615;341.17605981554544;351.546505008539;6297.2128483939505;6337.873242535153;6340.841478963028;6366.936330636692;6382.170317858672;6236.875262494747;6279.874402511947;6325;6337.841553961153;6358.777442789503;4846.709197448146;4855.223164293714;4857.8299759508245;4859.684120532154;4861.368022157115;4868.878278043059;4869.050535145648;4875.341828853113;4875.878103047435;4877.3903262092235;4739.028499157682;4814.951850481503;4817.397825271841;4818.10864989978;4831.922273422427;4817.301491283762;4821.397325334333;4823.348847905523;4829.830955916526;4841.903161936777;4054.0878302382025;4156.9792151039355;4198.6221240088535;4200.243956087903;4263.97868010661;6028.608140470856;6041;6041.516678665696;6042.395760423967;6071;5594.272744543224;5601.047821870292;5608.523275521586;5614.887702245973;5623.212750214973;6586.670666466657;6720.899186512206;6729.966350168218;6732.461403087741;6738;4613.5847773700525;4614.930776038362;4617.215073437524;4617.37665415168;4625.306204069383;6937.653117344163;6939.6877140528795;7002.614856182908;7010.123734533184;7014.088168538057;4693.178693728584;4704.717716936994;4706.058788242365;4724.338592597039;4727.57451829337;4606.378138951266;4733.597644200281;4748.240281554935;4750.786214620351;4771.212749896297;5532.395605274506;5536.833894983157;5537.307836520435;5548;5548.500634942875;6708.161479815023;6726.831829204211;6728.764493242811;6738.32616738332;6741.786478433929;1674.5060207238894;1696.686113069086;1698.8471037606676;1699.3202718912535;1703.2931333496708;1090.095220966596;1098.2916019167592;1114.0419239454063;1124.5726623882872;1125.9155563332783;6472.611643301417;6505.51208659343;6525.575837570637;6532.869342613121;6533.869322613521;6960.060391847137;6966.233714291424;6969.965150174318;6970.825729356705;6996;6376.7130479128555;6528.804135875931;6536.182977127859;6549.967250163719;6551.246606640202;3795.1460921292487;3798.4872042273937;3801.6008319126095;3803.809809509569;3818.7326887118193;7152.284771522806;7344.779656610311;7356.705731770669;7365.1530074042175;7376.815579610446;7218.422526197892;7261.128664560181;7271.018412514243;7276.308750668678;7278.199398066208;7164.749233776897;7311.670974806147;7327.523710958771;7330.523515971551;7336.963315183497;7016.894746578908;7018.438524917892;7061.611611361219;7072.504924655224;7077.5753454792875;6936.826579335355;6940.09778728762;6943.444524437932;6980.197277313174;6992.650367481708;7153.105861767279;7289.854202916018;7343;7343.669534871051;7344.816379590553;4652.32541281519;4707.764611769467;4708.246680531099;4712.835050773207;4726.929096063493;7022.613756243456;7022.964885175541;7023.543469674455;7025.297470252934;7044.964775176091;6674.8640435060315;6745.156855393076;6838.461346197066;6839.316068393121;6847.897281540681;6815.829604259933;6818.965905170442;6820.693068812015;6821.795346139624;6830.45356371499;6645.169353830771;6658.3674550917585;6682.064510968371;6690.665466726741;6692.598444093175;6659.367360100783;6839.350261725327;6886.001529778054;6887.829069058373;6899.793006209822;6694.866102677822;6697.062411262525;6708.262091170065;6708.295628959084;6719.5296329258435 09:55:05 INFO - 2015-11-17 09:55:05,502 DEBUG : BROWSER_OUTPUT: |5;yui.html;721.9675114619841;791.1455627921845;800.951942883427;814.1654803826082;827.3174630929483;13759.380827862746;14097.859021409782;14193.503227387044;14204.928975355122;14294.499692510764;12862.48550057999;12886.904613107898;12922.28927408992;12923.547675831347;13219.735605287888;808.8341889912554;821.4126899267023;827.2596026556229;827.6358402302998;837.5686521441462;804.5172896262225;832.184459229955;836.6569706420369;839.8194388206534;840.8444437779;862.1077185113409;868.6829307302852;871.4161511787117;872.9563521823883;873.1181506678237;864.8702694595798;866.2853146154384;868.7437206024207;868.9956550217272;869.2177040663422;624.4816802054283;627.5889292513411;628.8868003759321;630.8202162383699;631.6525910749069;13531.39108740109;13689.520866769615;13726;13758.793618095737;13759.724805503934;9724;9968.601255949754;10036.29745917786;10047.849282260771;10652.881447447984;9820.263480239011;10007.799844003152;10062.69811905644;10184.388936663823;10229.130523905476;3234.66036066212;3271.1495011296997;3298.9278484492634;3350.061982644839;3367.96632033679;47759.761201193774;47998.28002579929;48083.03833923337;48212.27681584779;48579.757101214265;7634.847303054019;7704.614769261514;7757.069151701832;7948.046234451903;8053.1141574426765;12305.569305074458;12322.81515777264;12323;12332.938335308267;12341.136120471481;6278.937210627835;6300.30696623371;6384.138141350951;6456.031595260749;6555.410013098844;4004.5795191505053;4044.272031034442;4051.7974101294817;4053.61490658387;4074.124063326399;2729.9044533441233;2737.274622225112;2748.491529067129;2751.545994910817;2756.1731480556155;421.1681928191797;436.0624656987502;436.45225242321317;438.6052552702593;451.0865497367791;513.9331886854685;590.2415396215928;591.1664552980277;645.5610185074195;668.8762578922915;8244.8351032979;8518.78703032429;8655.610497527627;8764.430312029697;8778.648854045767;532.6484520216638;598.0550729846832;618.329112912486;668.8194187569426;711.7010855440727;3871.96128038716;4118.91762164755;4203.117345357448;4214.4099826024385;4224.51418086924;58053.419465805644;58678.706606466694;58755.41244587585;58869;59402.70298648565;51203.23195152076;52167.478325217024;52418;52445.7377713109;52765.208521872206;48017.519824802;48045.519544804105;48478.757606211744;48614;48834;8216.671333146607;8318.500889946623;8325.95837020811;8330.958345208477;8404.285635721033;34653.306933861684;34779.652203478654;35587.28825423529;35750.28499429945;35777.46333805047;43426;44417.111657766014;46348.30477542907;47154;47399;8121.472104313437;8258.752237432887;8301.46040507365;8447.577621119042;8752.562371881508;11471.541138354707;11534.59628912984;11725.941370293094;12006.63980080599;12303.630891073282;11058.778824423627;11243.325400475998;11335.943320283346;11447.542098315975;11751.529938802352;10451.16390688728;10554.419506927192;10558.630447934593;10738.302010369302;11169;11064;11185.888141118485;11199.328040317607;11217.158713096387;11287.492062857355;8888.822223555622;8891.822163556822;9080.727578172402;9286.210672092677;9301.348905576815;8339;8382.664693412195;9122.224610907882;9152.58813353414;9168.54157292146 09:55:05 INFO - 2015-11-17 09:55:05,502 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:55:05 INFO - 2015-11-17 09:55:05,502 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:55:05 INFO - 2015-11-17 09:55:05,502 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,295 09:55:05 INFO - 2015-11-17 09:55:05,502 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:55:05 INFO - 2015-11-17 09:55:05,502 DEBUG : BROWSER_OUTPUT: __startTimestamp1447782905495__endTimestamp 09:55:05 INFO - 2015-11-17 09:55:05,502 DEBUG : BROWSER_OUTPUT: 09:55:05 INFO - 2015-11-17 09:55:05,502 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:55:05 INFO - 2015-11-17 09:55:05,503 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:55:05 INFO - 2015-11-17 09:55:05,504 DEBUG : BROWSER_OUTPUT: 09:55:05 INFO - 2015-11-17 09:55:05,504 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5533.96 Median:5808.07 stddev:627.71 (10.8%) stddev-sans-first:602.46 09:55:05 INFO - 2015-11-17 09:55:05,504 DEBUG : BROWSER_OUTPUT: Values: 3205.0 3284.5 3289.9 3306.5 3328.4 5260.3 5432.0 5432.6 5447.8 5485.8 5393.6 5418.0 5418.9 5528.9 5560.3 4943.4 5058.1 5118.1 5125.3 5138.0 5094.1 5111.9 5168.9 5195.2 5195.7 4914.7 5026.8 5130.6 5174.8 5201.0 4826.7 4920.2 4942.5 4951.9 4956.0 5007.7 5041.1 5043.0 5074.5 5097.4 5154.3 5306.9 5395.6 5398.2 5433.6 5866.5 5985.5 5986.1 6009.1 6046.1 6064.4 6085.0 6085.9 6087.2 6087.8 5393.8 5512.1 5540.4 5598.6 5662.6 5983.7 6077.5 6081.8 6082.1 6128.9 5863.7 5876.6 5900.5 5934.9 5939.9 5829.7 5953.1 5981.8 6018.3 6027.4 5864.4 5955.3 5976.4 5982.0 5987.4 5924.3 6023.8 6028.8 6035.1 6038.0 4639.5 4640.4 4643.9 4644.5 4686.7 3987.3 4013.6 4089.7 4119.1 4154.6 5538.3 5549.7 5552.4 5609.3 5677.0 5915.6 5918.9 5927.6 5956.4 5979.0 5398.5 5480.2 5720.7 5804.2 5868.4 5068.1 5099.1 5118.5 5131.3 5143.8 6012.9 6031.9 6047.1 6048.0 6075.4 5918.5 6022.5 6039.5 6068.6 6097.7 5969.4 6113.4 6156.9 6166.2 6174.2 5794.1 5974.7 5975.0 5981.5 5989.6 5913.2 5969.8 6027.7 6034.3 6060.9 5850.0 5894.4 5914.6 5924.6 5924.6 5723.7 5768.4 5891.0 5920.9 5935.1 5752.7 5808.1 5861.8 5874.7 5910.8 5833.9 5877.6 5882.8 5883.8 5924.5 5615.5 5645.2 5713.4 5771.0 5815.6 09:55:05 INFO - 2015-11-17 09:55:05,504 DEBUG : BROWSER_OUTPUT: 09:55:05 INFO - 2015-11-17 09:55:05,504 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:59774.71 Median:39890.40 stddev:131003.37 (328.4%) stddev-sans-first:131295.41 09:55:05 INFO - 2015-11-17 09:55:05,504 DEBUG : BROWSER_OUTPUT: Values: 552.8 584.2 588.3 594.5 598.4 37038.4 37299.3 37834.8 37839.0 37859.0 39833.8 39885.2 40318.4 40412.4 40470.8 8870.3 8991.3 9061.7 9073.6 9075.0 8763.1 8825.6 8834.1 8868.0 8871.3 8897.1 8918.7 8937.2 8962.4 9000.7 8811.4 8909.6 8917.6 8945.2 9010.5 8782.6 8804.6 8864.7 8883.1 8887.7 40793.0 40830.4 41264.2 41305.0 41404.8 3248.3 3273.5 3273.8 3287.4 3296.3 29854.0 30446.8 30510.5 30644.4 31170.4 3540.9 3586.3 3604.3 3611.2 3709.5 251977.0 254157.0 254716.0 255380.0 256239.7 59455.0 59763.4 59794.7 59857.7 59923.0 66906.7 67671.0 67871.7 68113.0 68175.0 16199.7 16362.2 16460.7 16492.4 16526.7 11866.5 11968.2 11994.6 12000.7 12061.8 20851.5 21131.3 21259.5 21287.5 21294.5 8304.7 8526.8 8591.8 8592.4 8666.8 946.5 1007.2 1063.7 1065.0 1129.8 29375.2 29759.9 30113.2 33048.5 33365.0 1012.2 1025.0 1062.3 1089.6 1120.4 14289.6 14428.4 14636.5 14784.2 14891.3 723514.0 740987.0 744767.0 745080.0 748176.0 55848.7 56371.2 56518.4 56598.0 56613.0 1351.6 1354.6 1361.9 1368.2 1372.6 29765.0 30460.0 30659.3 31221.0 31340.4 47569.5 47702.8 47940.5 48278.3 48322.0 308349.0 308822.0 309890.0 310154.0 311571.0 33845.2 46752.8 46927.3 47474.3 47566.8 43201.8 43939.6 44045.0 44047.1 44109.8 37138.8 37151.1 39628.0 40791.2 43297.8 39889.6 40053.4 40749.0 41145.2 41982.2 39485.8 39611.8 39834.6 39891.2 40084.0 38815.2 39870.6 40231.8 40388.0 40809.2 26826.7 27405.9 27412.0 27440.7 27491.6 09:55:05 INFO - 2015-11-17 09:55:05,504 DEBUG : BROWSER_OUTPUT: 09:55:05 INFO - 2015-11-17 09:55:05,504 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27337.46 Median:2341.17 stddev:89665.17 (3829.9%) stddev-sans-first:89893.82 09:55:05 INFO - 2015-11-17 09:55:05,505 DEBUG : BROWSER_OUTPUT: Values: 357.1 358.1 360.6 361.8 361.9 12645.3 13094.5 16986.8 17649.4 18931.3 11870.9 11876.2 11935.7 12443.5 12692.9 4509.8 4510.6 4603.2 4613.1 4618.0 4620.6 4659.2 4662.2 4662.2 4670.6 4603.9 4618.4 4625.6 4683.8 4810.7 4743.0 4750.0 4775.9 4801.4 4811.6 4139.3 4180.4 4225.2 4234.0 4249.6 13374.7 13399.9 13553.5 13743.1 13895.0 1951.3 2001.4 2035.6 2054.7 2150.1 10109.9 10167.1 10264.7 10425.1 10440.3 1723.2 1739.5 1747.2 1753.9 1768.9 59497.4 60922.0 61190.4 62079.0 62344.7 6865.3 7008.6 7159.5 7201.9 7242.2 8523.4 8565.9 8568.6 8580.2 8632.3 5542.9 5545.8 5584.4 5600.1 5612.4 5718.4 5733.4 5914.9 5948.2 5960.2 3320.9 3359.1 3361.3 3365.8 3381.4 1200.0 1208.4 1209.0 1209.5 1229.6 421.4 452.4 452.6 460.1 470.9 11066.3 11356.5 11364.1 11542.0 11658.1 432.8 438.4 442.3 449.3 452.7 6097.9 6258.9 6265.9 6354.9 6367.6 536074.0 541519.0 547148.0 547572.0 561050.0 74511.0 79902.6 81168.2 81524.0 82132.6 518.0 525.5 527.9 528.9 532.8 11583.2 11597.8 11605.4 11653.0 11782.0 35613.8 37043.4 37426.3 37575.1 38432.0 44876.0 45998.0 47843.0 48664.8 48767.3 6710.9 6896.3 6930.7 7190.9 7213.5 12740.4 12869.3 12918.9 13087.2 13207.3 10607.6 11038.6 11082.6 11195.1 11423.5 10267.5 10525.9 10603.6 10692.7 11019.7 11011.1 11012.0 11155.4 11159.7 11207.3 6844.8 6889.9 6946.4 6957.3 6996.2 10492.3 10864.0 11009.3 11202.3 11277.4 09:55:05 INFO - 2015-11-17 09:55:05,506 DEBUG : BROWSER_OUTPUT: 09:55:05 INFO - 2015-11-17 09:55:05,506 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5458.99 Median:6322.66 stddev:2847.19 (45.0%) stddev-sans-first:2839.29 09:55:05 INFO - 2015-11-17 09:55:05,506 DEBUG : BROWSER_OUTPUT: Values: 1456.6 1491.1 1615.0 1641.6 1749.1 7492.4 7665.9 7802.9 7897.2 7902.2 7995.4 8057.1 8141.5 8153.1 8154.3 2239.0 2246.1 2253.9 2265.6 2266.8 2283.5 2283.9 2322.5 2328.1 2335.5 1945.6 1977.6 2221.8 2228.1 2254.4 2143.8 2176.4 2177.1 2177.9 2185.1 2287.5 2288.5 2306.2 2314.4 2316.2 7740.7 7773.8 7841.0 7845.6 7847.0 4625.1 4714.5 4734.7 4738.0 4765.6 3046.6 3108.0 3158.4 3173.4 3194.2 1036.0 1042.7 1063.5 1063.6 1073.0 10852.8 10923.6 10935.1 10961.7 10984.6 4134.8 4136.5 4152.2 4178.7 4199.9 8733.6 8758.4 8782.1 8797.4 8809.3 4563.0 4585.4 4591.8 4596.9 4608.2 4262.0 4313.6 4320.5 4321.3 4327.5 3414.7 3430.4 3442.2 3449.4 3459.9 1052.8 1077.9 1084.6 1100.2 1105.9 1027.1 1027.7 1070.4 1279.5 1316.9 6913.0 7061.6 7082.8 7097.5 7106.8 1123.8 1126.4 1130.1 1141.3 1163.6 5911.0 5926.7 5936.5 5981.1 5988.6 9193.7 9429.7 9444.4 9477.8 9622.9 9455.8 9482.0 9498.1 9511.8 9531.8 6603.4 6682.6 6687.0 6718.0 7350.4 7071.3 7135.4 7163.8 7178.1 7191.0 8072.1 8188.7 8362.0 8408.2 8532.9 8333.5 8532.8 8595.2 8610.9 8657.5 7068.2 7143.0 7153.9 7184.5 7188.8 7678.1 7709.2 7712.7 7743.3 7760.7 6478.3 6890.1 6932.3 6956.9 6969.8 6709.5 6713.2 7002.9 7052.8 7157.2 7095.3 7153.4 7199.0 7201.1 7211.0 6209.3 6436.0 6439.4 6451.9 6458.0 6623.2 6651.1 6683.9 6685.3 6705.9 09:55:05 INFO - 2015-11-17 09:55:05,506 DEBUG : BROWSER_OUTPUT: 09:55:05 INFO - 2015-11-17 09:55:05,506 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5653.28 Median:6427.39 stddev:1731.98 (26.9%) stddev-sans-first:1690.14 09:55:05 INFO - 2015-11-17 09:55:05,506 DEBUG : BROWSER_OUTPUT: Values: 330.5 332.3 337.8 341.2 351.5 6297.2 6337.9 6340.8 6366.9 6382.2 6236.9 6279.9 6325.0 6337.8 6358.8 4846.7 4855.2 4857.8 4859.7 4861.4 4868.9 4869.1 4875.3 4875.9 4877.4 4739.0 4815.0 4817.4 4818.1 4831.9 4817.3 4821.4 4823.3 4829.8 4841.9 4054.1 4157.0 4198.6 4200.2 4264.0 6028.6 6041.0 6041.5 6042.4 6071.0 5594.3 5601.0 5608.5 5614.9 5623.2 6586.7 6720.9 6730.0 6732.5 6738.0 4613.6 4614.9 4617.2 4617.4 4625.3 6937.7 6939.7 7002.6 7010.1 7014.1 4693.2 4704.7 4706.1 4724.3 4727.6 4606.4 4733.6 4748.2 4750.8 4771.2 5532.4 5536.8 5537.3 5548.0 5548.5 6708.2 6726.8 6728.8 6738.3 6741.8 1674.5 1696.7 1698.8 1699.3 1703.3 1090.1 1098.3 1114.0 1124.6 1125.9 6472.6 6505.5 6525.6 6532.9 6533.9 6960.1 6966.2 6970.0 6970.8 6996.0 6376.7 6528.8 6536.2 6550.0 6551.2 3795.1 3798.5 3801.6 3803.8 3818.7 7152.3 7344.8 7356.7 7365.2 7376.8 7218.4 7261.1 7271.0 7276.3 7278.2 7164.7 7311.7 7327.5 7330.5 7337.0 7016.9 7018.4 7061.6 7072.5 7077.6 6936.8 6940.1 6943.4 6980.2 6992.7 7153.1 7289.9 7343.0 7343.7 7344.8 4652.3 4707.8 4708.2 4712.8 4726.9 7022.6 7023.0 7023.5 7025.3 7045.0 6674.9 6745.2 6838.5 6839.3 6847.9 6815.8 6819.0 6820.7 6821.8 6830.5 6645.2 6658.4 6682.1 6690.7 6692.6 6659.4 6839.4 6886.0 6887.8 6899.8 6694.9 6697.1 6708.3 6708.3 6719.5 09:55:05 INFO - 2015-11-17 09:55:05,506 DEBUG : BROWSER_OUTPUT: 09:55:05 INFO - 2015-11-17 09:55:05,506 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13471.05 Median:48724.00 stddev:16372.39 (33.6%) stddev-sans-first:16390.33 09:55:05 INFO - 2015-11-17 09:55:05,507 DEBUG : BROWSER_OUTPUT: Values: 722.0 791.1 801.0 814.2 827.3 13759.4 14097.9 14193.5 14204.9 14294.5 12862.5 12886.9 12922.3 12923.5 13219.7 808.8 821.4 827.3 827.6 837.6 804.5 832.2 836.7 839.8 840.8 862.1 868.7 871.4 873.0 873.1 864.9 866.3 868.7 869.0 869.2 624.5 627.6 628.9 630.8 631.7 13531.4 13689.5 13726.0 13758.8 13759.7 9724.0 9968.6 10036.3 10047.8 10652.9 9820.3 10007.8 10062.7 10184.4 10229.1 3234.7 3271.1 3298.9 3350.1 3368.0 47759.8 47998.3 48083.0 48212.3 48579.8 7634.8 7704.6 7757.1 7948.0 8053.1 12305.6 12322.8 12323.0 12332.9 12341.1 6278.9 6300.3 6384.1 6456.0 6555.4 4004.6 4044.3 4051.8 4053.6 4074.1 2729.9 2737.3 2748.5 2751.5 2756.2 421.2 436.1 436.5 438.6 451.1 513.9 590.2 591.2 645.6 668.9 8244.8 8518.8 8655.6 8764.4 8778.6 532.6 598.1 618.3 668.8 711.7 3872.0 4118.9 4203.1 4214.4 4224.5 58053.4 58678.7 58755.4 58869.0 59402.7 51203.2 52167.5 52418.0 52445.7 52765.2 48017.5 48045.5 48478.8 48614.0 48834.0 8216.7 8318.5 8326.0 8331.0 8404.3 34653.3 34779.7 35587.3 35750.3 35777.5 43426.0 44417.1 46348.3 47154.0 47399.0 8121.5 8258.8 8301.5 8447.6 8752.6 11471.5 11534.6 11725.9 12006.6 12303.6 11058.8 11243.3 11335.9 11447.5 11751.5 10451.2 10554.4 10558.6 10738.3 11169.0 11064.0 11185.9 11199.3 11217.2 11287.5 8888.8 8891.8 9080.7 9286.2 9301.3 8339.0 8382.7 9122.2 9152.6 9168.5 09:55:05 INFO - 2015-11-17 09:55:05,508 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:55:05 INFO - 2015-11-17 09:55:05,508 DEBUG : BROWSER_OUTPUT: 09:55:06 INFO - 2015-11-17 09:55:06,138 INFO : Browser exited with error code: 0 09:55:06 INFO - 2015-11-17 09:55:06,154 INFO : Completed test dromaeo_css (00:18:30) 09:55:06 INFO - 2015-11-17 09:55:06,154 INFO : Starting test kraken 09:55:06 INFO - 2015-11-17 09:55:06,154 DEBUG : operating with platform_type : linux_ 09:55:06 INFO - 2015-11-17 09:55:06,154 INFO : Initialising browser for kraken test... 09:55:06 INFO - 2015-11-17 09:55:06,160 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyeUmZW/profile http://localhost:50867/getInfo.html 09:55:10 INFO - 2015-11-17 09:55:10,403 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:55:10 INFO - 2015-11-17 09:55:10,403 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:55:10 INFO - 2015-11-17 09:55:10,404 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:55:10 INFO - 2015-11-17 09:55:10,404 DEBUG : BROWSER_OUTPUT: __metrics 09:55:11 INFO - 2015-11-17 09:55:11,390 INFO : Browser initialized. 09:55:11 INFO - 2015-11-17 09:55:11,390 INFO : Running cycle 1/1 for kraken test... 09:55:11 INFO - 2015-11-17 09:55:11,390 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyeUmZW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:55:23 INFO - 2015-11-17 09:55:23,178 DEBUG : BROWSER_OUTPUT: RSS: Main: 141836288 09:55:23 INFO - 2015-11-17 09:55:23,178 DEBUG : BROWSER_OUTPUT: 09:55:25 INFO - 2015-11-17 09:55:25,654 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50867/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50867/tests/kraken/driver.html?testName=audio-beat-detection) 09:55:26 INFO - 2015-11-17 09:55:26,256 DEBUG : BROWSER_OUTPUT: RSS: Main: 142266368 09:55:26 INFO - 2015-11-17 09:55:26,256 DEBUG : BROWSER_OUTPUT: 09:55:28 INFO - 2015-11-17 09:55:28,897 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50867/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50867/tests/kraken/driver.html?testName=audio-dft) 09:55:29 INFO - 2015-11-17 09:55:29,499 DEBUG : BROWSER_OUTPUT: RSS: Main: 141975552 09:55:29 INFO - 2015-11-17 09:55:29,499 DEBUG : BROWSER_OUTPUT: 09:55:32 INFO - 2015-11-17 09:55:32,342 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50867/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50867/tests/kraken/driver.html?testName=audio-fft) 09:55:32 INFO - 2015-11-17 09:55:32,924 DEBUG : BROWSER_OUTPUT: RSS: Main: 136200192 09:55:32 INFO - 2015-11-17 09:55:32,924 DEBUG : BROWSER_OUTPUT: 09:55:34 INFO - 2015-11-17 09:55:34,920 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50867/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50867/tests/kraken/driver.html?testName=audio-oscillator) 09:55:35 INFO - 2015-11-17 09:55:35,501 DEBUG : BROWSER_OUTPUT: RSS: Main: 136962048 09:55:35 INFO - 2015-11-17 09:55:35,501 DEBUG : BROWSER_OUTPUT: 09:55:37 INFO - 2015-11-17 09:55:37,662 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50867/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50867/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:55:38 INFO - 2015-11-17 09:55:38,244 DEBUG : BROWSER_OUTPUT: RSS: Main: 137375744 09:55:38 INFO - 2015-11-17 09:55:38,244 DEBUG : BROWSER_OUTPUT: 09:55:41 INFO - 2015-11-17 09:55:41,263 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50867/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50867/tests/kraken/driver.html?testName=imaging-darkroom) 09:55:41 INFO - 2015-11-17 09:55:41,850 DEBUG : BROWSER_OUTPUT: RSS: Main: 137310208 09:55:41 INFO - 2015-11-17 09:55:41,850 DEBUG : BROWSER_OUTPUT: 09:55:45 INFO - 2015-11-17 09:55:45,261 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50867/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50867/tests/kraken/driver.html?testName=imaging-desaturate) 09:55:45 INFO - 2015-11-17 09:55:45,847 DEBUG : BROWSER_OUTPUT: RSS: Main: 138727424 09:55:45 INFO - 2015-11-17 09:55:45,847 DEBUG : BROWSER_OUTPUT: 09:55:48 INFO - 2015-11-17 09:55:48,685 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50867/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50867/tests/kraken/driver.html?testName=json-parse-financial) 09:55:49 INFO - 2015-11-17 09:55:49,278 DEBUG : BROWSER_OUTPUT: RSS: Main: 139149312 09:55:49 INFO - 2015-11-17 09:55:49,279 DEBUG : BROWSER_OUTPUT: 09:55:50 INFO - 2015-11-17 09:55:50,868 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50867/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50867/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:55:51 INFO - 2015-11-17 09:55:51,441 DEBUG : BROWSER_OUTPUT: RSS: Main: 139763712 09:55:51 INFO - 2015-11-17 09:55:51,441 DEBUG : BROWSER_OUTPUT: 09:55:53 INFO - 2015-11-17 09:55:53,277 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50867/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50867/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:55:53 INFO - 2015-11-17 09:55:53,886 DEBUG : BROWSER_OUTPUT: RSS: Main: 139579392 09:55:53 INFO - 2015-11-17 09:55:53,887 DEBUG : BROWSER_OUTPUT: 09:55:55 INFO - 2015-11-17 09:55:55,965 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50867/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50867/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:55:56 INFO - 2015-11-17 09:55:56,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 139816960 09:55:56 INFO - 2015-11-17 09:55:56,551 DEBUG : BROWSER_OUTPUT: 09:55:59 INFO - 2015-11-17 09:55:59,006 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50867/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50867/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:55:59 INFO - 2015-11-17 09:55:59,612 DEBUG : BROWSER_OUTPUT: RSS: Main: 139849728 09:55:59 INFO - 2015-11-17 09:55:59,612 DEBUG : BROWSER_OUTPUT: 09:56:02 INFO - 2015-11-17 09:56:02,187 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50867/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50867/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:56:02 INFO - 2015-11-17 09:56:02,774 DEBUG : BROWSER_OUTPUT: RSS: Main: 139821056 09:56:02 INFO - 2015-11-17 09:56:02,774 DEBUG : BROWSER_OUTPUT: 09:56:04 INFO - 2015-11-17 09:56:04,463 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50867/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50867/tests/kraken/driver.html?testName=ai-astar) 09:56:04 INFO - 2015-11-17 09:56:04,709 DEBUG : BROWSER_OUTPUT: RSS: Main: 140455936 09:56:04 INFO - 2015-11-17 09:56:04,710 DEBUG : BROWSER_OUTPUT: 09:56:04 INFO - 2015-11-17 09:56:04,711 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:56:04 INFO - 2015-11-17 09:56:04,711 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:56:04 INFO - 2015-11-17 09:56:04,711 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:56:04 INFO - 2015-11-17 09:56:04,711 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:56:04 INFO - 2015-11-17 09:56:04,711 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;105;111;110;115;124;111;112;110;112 09:56:04 INFO - 2015-11-17 09:56:04,712 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;162;129;149;159;125;153;153;127;162;126 09:56:04 INFO - 2015-11-17 09:56:04,712 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;162;163;163;160;163;164;173;163 09:56:04 INFO - 2015-11-17 09:56:04,712 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;77;71;74;73;135;83;71;73;72 09:56:04 INFO - 2015-11-17 09:56:04,712 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;91;138;91;91;90;141;90;90;128 09:56:04 INFO - 2015-11-17 09:56:04,712 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;110;111;110;110;110;110;110;111 09:56:04 INFO - 2015-11-17 09:56:04,712 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;146;147;147;147;147;146;146 09:56:04 INFO - 2015-11-17 09:56:04,712 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;98;96;97;96;98;96;97;98;96 09:56:04 INFO - 2015-11-17 09:56:04,712 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;61;64;62;62;62;62;62;61;60 09:56:04 INFO - 2015-11-17 09:56:04,713 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;70;70;70;69;71;69;70 09:56:04 INFO - 2015-11-17 09:56:04,713 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;94;90;86;86;84;85;87;85;86 09:56:04 INFO - 2015-11-17 09:56:04,713 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;125;123;133;116;131;133;118;124;121;118 09:56:04 INFO - 2015-11-17 09:56:04,713 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;147;155;150;151;139;146;151;150;152 09:56:04 INFO - 2015-11-17 09:56:04,713 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;66;68;68;70;66;66;67;65;66 09:56:04 INFO - 2015-11-17 09:56:04,713 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:56:04 INFO - 2015-11-17 09:56:04,713 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:56:04 INFO - 2015-11-17 09:56:04,714 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,717 09:56:04 INFO - 2015-11-17 09:56:04,714 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:56:04 INFO - 2015-11-17 09:56:04,714 DEBUG : BROWSER_OUTPUT: __startTimestamp1447782964710__endTimestamp 09:56:04 INFO - 2015-11-17 09:56:04,714 DEBUG : BROWSER_OUTPUT: 09:56:04 INFO - 2015-11-17 09:56:04,717 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:56:04 INFO - 2015-11-17 09:56:04,718 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:56:04 INFO - 2015-11-17 09:56:04,718 DEBUG : BROWSER_OUTPUT: 09:56:04 INFO - 2015-11-17 09:56:04,718 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.20 Median:112.00 stddev:4.85 (4.3%) stddev-sans-first:5.14 09:56:04 INFO - 2015-11-17 09:56:04,718 DEBUG : BROWSER_OUTPUT: Values: 112.0 105.0 111.0 110.0 115.0 124.0 111.0 112.0 110.0 112.0 09:56:04 INFO - 2015-11-17 09:56:04,718 DEBUG : BROWSER_OUTPUT: 09:56:04 INFO - 2015-11-17 09:56:04,718 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.50 Median:153.00 stddev:15.83 (10.3%) stddev-sans-first:15.48 09:56:04 INFO - 2015-11-17 09:56:04,718 DEBUG : BROWSER_OUTPUT: Values: 162.0 129.0 149.0 159.0 125.0 153.0 153.0 127.0 162.0 126.0 09:56:04 INFO - 2015-11-17 09:56:04,718 DEBUG : BROWSER_OUTPUT: 09:56:04 INFO - 2015-11-17 09:56:04,718 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:3.47 (2.1%) stddev-sans-first:3.63 09:56:04 INFO - 2015-11-17 09:56:04,719 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 162.0 163.0 163.0 160.0 163.0 164.0 173.0 163.0 09:56:04 INFO - 2015-11-17 09:56:04,719 DEBUG : BROWSER_OUTPUT: 09:56:04 INFO - 2015-11-17 09:56:04,720 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.20 Median:73.00 stddev:19.58 (26.8%) stddev-sans-first:20.60 09:56:04 INFO - 2015-11-17 09:56:04,720 DEBUG : BROWSER_OUTPUT: Values: 73.0 77.0 71.0 74.0 73.0 135.0 83.0 71.0 73.0 72.0 09:56:04 INFO - 2015-11-17 09:56:04,720 DEBUG : BROWSER_OUTPUT: 09:56:04 INFO - 2015-11-17 09:56:04,720 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.10 Median:90.50 stddev:22.02 (24.3%) stddev-sans-first:22.84 09:56:04 INFO - 2015-11-17 09:56:04,720 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 138.0 91.0 91.0 90.0 141.0 90.0 90.0 128.0 09:56:04 INFO - 2015-11-17 09:56:04,720 DEBUG : BROWSER_OUTPUT: 09:56:04 INFO - 2015-11-17 09:56:04,720 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 09:56:04 INFO - 2015-11-17 09:56:04,720 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 110.0 111.0 110.0 110.0 110.0 110.0 110.0 111.0 09:56:04 INFO - 2015-11-17 09:56:04,720 DEBUG : BROWSER_OUTPUT: 09:56:04 INFO - 2015-11-17 09:56:04,721 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 09:56:04 INFO - 2015-11-17 09:56:04,721 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 146.0 147.0 147.0 147.0 147.0 146.0 146.0 09:56:04 INFO - 2015-11-17 09:56:04,721 DEBUG : BROWSER_OUTPUT: 09:56:04 INFO - 2015-11-17 09:56:04,721 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.90 Median:97.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 09:56:04 INFO - 2015-11-17 09:56:04,721 DEBUG : BROWSER_OUTPUT: Values: 97.0 98.0 96.0 97.0 96.0 98.0 96.0 97.0 98.0 96.0 09:56:04 INFO - 2015-11-17 09:56:04,721 DEBUG : BROWSER_OUTPUT: 09:56:04 INFO - 2015-11-17 09:56:04,721 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.80 Median:62.00 stddev:1.03 (1.7%) stddev-sans-first:1.09 09:56:04 INFO - 2015-11-17 09:56:04,721 DEBUG : BROWSER_OUTPUT: Values: 62.0 61.0 64.0 62.0 62.0 62.0 62.0 62.0 61.0 60.0 09:56:04 INFO - 2015-11-17 09:56:04,721 DEBUG : BROWSER_OUTPUT: 09:56:04 INFO - 2015-11-17 09:56:04,721 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 09:56:04 INFO - 2015-11-17 09:56:04,721 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 70.0 70.0 70.0 69.0 71.0 69.0 70.0 09:56:04 INFO - 2015-11-17 09:56:04,721 DEBUG : BROWSER_OUTPUT: 09:56:04 INFO - 2015-11-17 09:56:04,721 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:86.00 stddev:3.01 (3.5%) stddev-sans-first:3.12 09:56:04 INFO - 2015-11-17 09:56:04,721 DEBUG : BROWSER_OUTPUT: Values: 85.0 94.0 90.0 86.0 86.0 84.0 85.0 87.0 85.0 86.0 09:56:04 INFO - 2015-11-17 09:56:04,721 DEBUG : BROWSER_OUTPUT: 09:56:04 INFO - 2015-11-17 09:56:04,722 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:124.50 stddev:6.30 (5.1%) stddev-sans-first:6.68 09:56:04 INFO - 2015-11-17 09:56:04,722 DEBUG : BROWSER_OUTPUT: Values: 125.0 123.0 133.0 116.0 131.0 133.0 118.0 124.0 121.0 118.0 09:56:04 INFO - 2015-11-17 09:56:04,722 DEBUG : BROWSER_OUTPUT: 09:56:04 INFO - 2015-11-17 09:56:04,722 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.00 Median:150.50 stddev:5.35 (3.6%) stddev-sans-first:4.58 09:56:04 INFO - 2015-11-17 09:56:04,722 DEBUG : BROWSER_OUTPUT: Values: 139.0 147.0 155.0 150.0 151.0 139.0 146.0 151.0 150.0 152.0 09:56:04 INFO - 2015-11-17 09:56:04,722 DEBUG : BROWSER_OUTPUT: 09:56:04 INFO - 2015-11-17 09:56:04,722 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:1.75 (2.6%) stddev-sans-first:1.54 09:56:04 INFO - 2015-11-17 09:56:04,722 DEBUG : BROWSER_OUTPUT: Values: 70.0 66.0 68.0 68.0 70.0 66.0 66.0 67.0 65.0 66.0 09:56:04 INFO - 2015-11-17 09:56:04,722 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:56:04 INFO - 2015-11-17 09:56:04,722 DEBUG : BROWSER_OUTPUT: 09:56:05 INFO - 2015-11-17 09:56:05,550 INFO : Browser exited with error code: 0 09:56:05 INFO - 2015-11-17 09:56:05,597 INFO : Completed test kraken (00:00:59) 09:56:05 INFO - 2015-11-17 09:56:05,597 INFO : Starting test v8_7 09:56:05 INFO - 2015-11-17 09:56:05,597 DEBUG : operating with platform_type : linux_ 09:56:05 INFO - 2015-11-17 09:56:05,597 INFO : Initialising browser for v8_7 test... 09:56:05 INFO - 2015-11-17 09:56:05,603 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEveEbo/profile http://localhost:50867/getInfo.html 09:56:09 INFO - 2015-11-17 09:56:09,946 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:56:09 INFO - 2015-11-17 09:56:09,947 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:56:09 INFO - 2015-11-17 09:56:09,947 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:56:09 INFO - 2015-11-17 09:56:09,947 DEBUG : BROWSER_OUTPUT: __metrics 09:56:10 INFO - 2015-11-17 09:56:10,986 INFO : Browser initialized. 09:56:10 INFO - 2015-11-17 09:56:10,986 INFO : Running cycle 1/1 for v8_7 test... 09:56:10 INFO - 2015-11-17 09:56:10,986 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEveEbo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:56:22 INFO - 2015-11-17 09:56:22,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 141021184 09:56:22 INFO - 2015-11-17 09:56:22,780 DEBUG : BROWSER_OUTPUT: 09:56:44 INFO - 2015-11-17 09:56:44,163 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50867/tests/v8_7/run.html (next: http://localhost:50867/tests/v8_7/run.html) 09:56:44 INFO - 2015-11-17 09:56:44,413 DEBUG : BROWSER_OUTPUT: RSS: Main: 135827456 09:56:44 INFO - 2015-11-17 09:56:44,414 DEBUG : BROWSER_OUTPUT: 09:56:44 INFO - 2015-11-17 09:56:44,414 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:56:44 INFO - 2015-11-17 09:56:44,414 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:56:44 INFO - 2015-11-17 09:56:44,414 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:56:44 INFO - 2015-11-17 09:56:44,414 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:56:44 INFO - 2015-11-17 09:56:44,415 DEBUG : BROWSER_OUTPUT: |0;Richards;166.16816218012627 09:56:44 INFO - 2015-11-17 09:56:44,415 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;189.64536317087047 09:56:44 INFO - 2015-11-17 09:56:44,415 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.0336040324839 09:56:44 INFO - 2015-11-17 09:56:44,415 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5086.294416243655 09:56:44 INFO - 2015-11-17 09:56:44,415 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1055.9662090813094 09:56:44 INFO - 2015-11-17 09:56:44,416 DEBUG : BROWSER_OUTPUT: |5;Earley;715.8196134574088 09:56:44 INFO - 2015-11-17 09:56:44,416 DEBUG : BROWSER_OUTPUT: |6;Boyer;12096.385542168675 09:56:44 INFO - 2015-11-17 09:56:44,416 DEBUG : BROWSER_OUTPUT: |7;RegExp;25075 09:56:44 INFO - 2015-11-17 09:56:44,416 DEBUG : BROWSER_OUTPUT: |8;Splay;651.5249837767683 09:56:44 INFO - 2015-11-17 09:56:44,416 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 09:56:44 INFO - 2015-11-17 09:56:44,417 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:56:44 INFO - 2015-11-17 09:56:44,417 DEBUG : BROWSER_OUTPUT: __startTimestamp1447783004411__endTimestamp 09:56:44 INFO - 2015-11-17 09:56:44,417 DEBUG : BROWSER_OUTPUT: 09:56:44 INFO - 2015-11-17 09:56:44,417 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:56:44 INFO - 2015-11-17 09:56:44,417 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:56:44 INFO - 2015-11-17 09:56:44,418 DEBUG : BROWSER_OUTPUT: 09:56:44 INFO - 2015-11-17 09:56:44,418 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.17 Median:166.17 stddev:0.00 (0.0%) 09:56:44 INFO - 2015-11-17 09:56:44,418 DEBUG : BROWSER_OUTPUT: Values: 166.2 09:56:44 INFO - 2015-11-17 09:56:44,418 DEBUG : BROWSER_OUTPUT: 09:56:44 INFO - 2015-11-17 09:56:44,418 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:189.65 Median:189.65 stddev:0.00 (0.0%) 09:56:44 INFO - 2015-11-17 09:56:44,418 DEBUG : BROWSER_OUTPUT: Values: 189.6 09:56:44 INFO - 2015-11-17 09:56:44,419 DEBUG : BROWSER_OUTPUT: 09:56:44 INFO - 2015-11-17 09:56:44,419 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.03 Median:280.03 stddev:0.00 (0.0%) 09:56:44 INFO - 2015-11-17 09:56:44,419 DEBUG : BROWSER_OUTPUT: Values: 280.0 09:56:44 INFO - 2015-11-17 09:56:44,419 DEBUG : BROWSER_OUTPUT: 09:56:44 INFO - 2015-11-17 09:56:44,419 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5086.29 Median:5086.29 stddev:0.00 (0.0%) 09:56:44 INFO - 2015-11-17 09:56:44,419 DEBUG : BROWSER_OUTPUT: Values: 5086.3 09:56:44 INFO - 2015-11-17 09:56:44,420 DEBUG : BROWSER_OUTPUT: 09:56:44 INFO - 2015-11-17 09:56:44,420 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1055.97 Median:1055.97 stddev:0.00 (0.0%) 09:56:44 INFO - 2015-11-17 09:56:44,420 DEBUG : BROWSER_OUTPUT: Values: 1056.0 09:56:44 INFO - 2015-11-17 09:56:44,420 DEBUG : BROWSER_OUTPUT: 09:56:44 INFO - 2015-11-17 09:56:44,420 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:715.82 Median:715.82 stddev:0.00 (0.0%) 09:56:44 INFO - 2015-11-17 09:56:44,421 DEBUG : BROWSER_OUTPUT: Values: 715.8 09:56:44 INFO - 2015-11-17 09:56:44,421 DEBUG : BROWSER_OUTPUT: 09:56:44 INFO - 2015-11-17 09:56:44,421 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12096.39 Median:12096.39 stddev:0.00 (0.0%) 09:56:44 INFO - 2015-11-17 09:56:44,421 DEBUG : BROWSER_OUTPUT: Values: 12096.4 09:56:44 INFO - 2015-11-17 09:56:44,421 DEBUG : BROWSER_OUTPUT: 09:56:44 INFO - 2015-11-17 09:56:44,421 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25075.00 Median:25075.00 stddev:0.00 (0.0%) 09:56:44 INFO - 2015-11-17 09:56:44,422 DEBUG : BROWSER_OUTPUT: Values: 25075.0 09:56:44 INFO - 2015-11-17 09:56:44,422 DEBUG : BROWSER_OUTPUT: 09:56:44 INFO - 2015-11-17 09:56:44,422 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:651.52 Median:651.52 stddev:0.00 (0.0%) 09:56:44 INFO - 2015-11-17 09:56:44,422 DEBUG : BROWSER_OUTPUT: Values: 651.5 09:56:44 INFO - 2015-11-17 09:56:44,422 DEBUG : BROWSER_OUTPUT: 09:56:44 INFO - 2015-11-17 09:56:44,422 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 09:56:44 INFO - 2015-11-17 09:56:44,423 DEBUG : BROWSER_OUTPUT: Values: 4830.9 09:56:44 INFO - 2015-11-17 09:56:44,423 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:56:44 INFO - 2015-11-17 09:56:44,423 DEBUG : BROWSER_OUTPUT: 09:56:45 INFO - 2015-11-17 09:56:45,274 INFO : Browser exited with error code: 0 09:56:45 INFO - 2015-11-17 09:56:45,291 INFO : Completed test v8_7 (00:00:39) 09:56:45 INFO - 2015-11-17 09:56:45,503 INFO : Completed test suite (00:20:09) 09:56:45 INFO - 2015-11-17 09:56:45,503 DEBUG : Working with test: dromaeo_css 09:56:45 INFO - 2015-11-17 09:56:45,503 DEBUG : Generating results file: dromaeo_css 09:56:45 INFO - 2015-11-17 09:56:45,504 DEBUG : Working with test: kraken 09:56:45 INFO - 2015-11-17 09:56:45,505 DEBUG : Generating results file: kraken 09:56:45 INFO - 2015-11-17 09:56:45,505 INFO : javascript benchmark 09:56:45 INFO - 2015-11-17 09:56:45,505 DEBUG : Working with test: v8_7 09:56:45 INFO - 2015-11-17 09:56:45,505 DEBUG : Generating results file: v8_7 09:56:45 INFO - 2015-11-17 09:56:45,505 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:56:45 INFO - 2015-11-17 09:56:45,647 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 09:56:45 INFO - 2015-11-17 09:56:45,647 DEBUG : process_Request line: dromaeo_css 6844.68 graph.html#tests=[[72,63,43]] 09:56:45 INFO - 2015-11-17 09:56:45,647 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:56:45 INFO - 2015-11-17 09:56:45,688 DEBUG : process_Request line: kraken 1516.00 graph.html#tests=[[232,63,43]] 09:56:45 INFO - 2015-11-17 09:56:45,688 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:56:45 INFO - 2015-11-17 09:56:45,724 DEBUG : process_Request line: v8_7 21301.35 graph.html#tests=[[230,63,43]] 09:56:45 INFO - 2015-11-17 09:56:45,725 INFO : javascript benchmark 09:56:45 INFO - 2015-11-17 09:56:45,729 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [357.07339454116567, 358.0904502563489, 360.61234173263733, 361.79377754679825, 361.86068363679976, 12645.304508252066, 13094.47622095115, 16986.83013169868, 17649.382271620496, 18931.33740319089, 11870.940645296761, 11876.228045177057, 11935.701607459818, 12443.506779186488, 12692.93653531731, 4509.751963641998, 4510.594046535811, 4603.171429142753, 4613.100445413146, 4617.953820461786, 4620.630349572043, 4659.231226847566, 4662.160811054009, 4662.207424737802, 4670.579647831694, 4603.907921841561, 4618.399608050949, 4625.629949604024, 4683.812647494096, 4810.68730532516, 4742.95257047432, 4750.0, 4775.904481910342, 4801.351817504645, 4811.639127065467, 4139.2963196256405, 4180.393842892794, 4225.176090662322, 4234.047339348653, 4249.553796851317, 13374.732505349839, 13399.933000334935, 13553.457861685521, 13743.106698064594, 13895.0, 1951.2585217617357, 2001.4295925661263, 2035.6437623415843, 2054.681524363726, 2150.0754675489534, 10109.938456462112, 10167.084962353423, 10264.74338141545, 10425.113865321457, 10440.32137911041, 1723.1987125986477, 1739.5042412912385, 1747.1788259518132, 1753.8509226715744, 1768.9027103509302, 59497.40502594962, 60922.0, 61190.38809611891, 62079.0, 62344.68827655878, 6865.27914568973, 7008.649567521604, 7159.498835081598, 7201.927980720126, 7242.239564845615, 8523.445976011664, 8565.871511927326, 8568.614412351459, 8580.227779499875, 8632.309415246891, 5542.889142217133, 5545.805896793593, 5584.4136365681015, 5600.103983362643, 5612.438756124355, 5718.399568045378, 5733.426657334233, 5914.9112763308585, 5948.226730525091, 5960.195373624592, 3320.9169770755925, 3359.093044877918, 3361.2941282330494, 3365.848536815849, 3381.4420620597816, 1200.0459634590522, 1208.4018410886667, 1208.9697757556132, 1209.5101483899034, 1229.6495498782804, 421.3637407514675, 452.3937923182951, 452.5723191583987, 460.0775445232355, 470.9434867815884, 11066.336019838835, 11356.48895799691, 11364.147688923364, 11542.0, 11658.125640576991, 432.77711978331183, 438.3599944081613, 442.2592158135111, 449.3484447551064, 452.6763364194551, 6097.878042439126, 6258.90606160255, 6265.937340626535, 6354.936450635527, 6367.554271200971, 536074.0, 541519.0, 547148.0, 547572.0, 561050.0, 74511.0, 79902.6004869972, 81168.18831811725, 81524.0, 82132.58933705294, 517.9922301165485, 525.5138996428288, 527.9181726832347, 528.9471052894756, 532.8108521474899, 11583.247088939192, 11597.768044638891, 11605.361705106301, 11653.0, 11782.0, 35613.82193089018, 37043.444348334255, 37426.25147497089, 37575.060623484635, 38432.03919902025, 44876.0, 45998.0, 47843.0, 48664.75667621639, 48767.26849097337, 6710.932890671226, 6896.310368963063, 6930.653467326512, 7190.89213661785, 7213.495055346076, 12740.4266807992, 12869.2921889297, 12918.935405322913, 13087.214767114003, 13207.273599952096, 10607.628732994308, 11038.558457661604, 11082.61210857616, 11195.10439164881, 11423.543058277575, 10267.486625668836, 10525.9473702631, 10603.628872989408, 10692.732681683021, 11019.669409917715, 11011.119110470983, 11012.017836789455, 11155.386453745123, 11159.665210043388, 11207.327560346404, 6844.828879278058, 6889.931100689129, 6946.409555187865, 6957.2694867038235, 6996.230414654282, 10492.265541412027, 10864.0, 11009.339439633648, 11202.327860328407, 11277.379744114152], "dojo.html": [3204.9839750801243, 3284.458064419371, 3289.8848540301096, 3306.470964645657, 3328.400887840189, 5260.316158899338, 5432.0493913565115, 5432.619716619838, 5447.836564903055, 5485.753141108649, 5393.568514518839, 5417.972910135453, 5418.943306055321, 5528.944710552893, 5560.304961879765, 4943.431505376882, 5058.0895438821, 5118.129917913963, 5125.256837758523, 5138.0, 5094.083065048289, 5111.897762044757, 5168.9224661630105, 5195.194744814541, 5195.688258704471, 4914.70511769295, 5026.824061157842, 5130.640855140142, 5174.844754657385, 5201.0, 4826.734529600871, 4920.237363208708, 4942.456329803718, 4951.876203094916, 4955.950440495621, 5007.674501157413, 5041.067402530543, 5042.974785126051, 5074.467180945984, 5097.388313402378, 5154.252633368178, 5306.893862122736, 5395.568354531628, 5398.163284690879, 5433.565314774809, 5866.530677545828, 5985.4912332451795, 5986.07215881539, 6009.06859436788, 6046.09308603713, 6064.423879731418, 6085.026395776698, 6085.934961381785, 6087.239095113111, 6087.817365479043, 5393.838184854421, 5512.062949298629, 5540.445955404468, 5598.608097433182, 5662.6036177467595, 5983.700814959235, 6077.453029227391, 6081.8479538011015, 6082.148499210114, 6128.877422451526, 5863.706814659336, 5876.588638795243, 5900.527957763368, 5934.910976335358, 5939.851503712355, 5829.650220986669, 5953.077273022688, 5981.820545383645, 6018.277806663141, 6027.36712645166, 5864.38423965486, 5955.3151387590115, 5976.372480889531, 5981.970090149522, 5987.401259873977, 5924.318703349084, 6023.849403764941, 6028.788992385245, 6035.1249068885645, 6037.973544497446, 4639.466461356988, 4640.396748422683, 4643.883902902455, 4644.535546445329, 4686.74222917736, 3987.342088555356, 4013.5986401359633, 4089.7137200396282, 4119.114390406077, 4154.626083652425, 5538.280023596906, 5549.694766787785, 5552.41699621542, 5609.298837645294, 5676.971615141898, 5915.585908986416, 5918.911216331759, 5927.585069045125, 5956.404359564009, 5979.0433530635755, 5398.46015398457, 5480.232767412565, 5720.713964301768, 5804.187413762077, 5868.383819698955, 5068.138416469209, 5099.107656160157, 5118.513741194581, 5131.307273518028, 5143.794248230104, 6012.87974240504, 6031.879362412815, 6047.0627052806885, 6047.9770284551405, 6075.362086980892, 5918.496927761188, 6022.48808851235, 6039.516838652985, 6068.575199735976, 6097.695115244132, 5969.403059694169, 6113.358097399887, 6156.907646385397, 6166.1983942087245, 6174.228221472316, 5794.072948328248, 5974.671393073423, 5975.014122669884, 5981.491573216152, 5989.64062156272, 5913.172155898264, 5969.76120955157, 6027.698615069141, 6034.275886893601, 6060.909086363797, 5849.970750146222, 5894.38108998549, 5914.645121292736, 5924.644521328734, 5924.644521328734, 5723.713814309184, 5768.423157684198, 5891.0, 5920.911186332295, 5935.109733540004, 5752.654840709571, 5808.070708686759, 5861.794837180678, 5874.706264686834, 5910.822675319747, 5833.883322333614, 5877.647341159544, 5882.764689412375, 5883.823485295448, 5924.4667979882015, 5615.494605485526, 5645.237892884408, 5713.371529131875, 5771.0, 5815.5929084963645], "mootools.html": [1456.563031090673, 1491.1276903011737, 1615.0, 1641.5567796694893, 1749.1341785816014, 7492.438067144965, 7665.8850117248285, 7802.882956755653, 7897.170797066305, 7902.170272121423, 7995.44031917766, 8057.073436554798, 8141.470804397725, 8153.143919888415, 8154.347652187826, 2239.0, 2246.1015593762545, 2253.8985745641485, 2265.6261716816707, 2266.841321107523, 2283.4519715268384, 2283.942901427469, 2322.477442575424, 2328.080408238745, 2335.544568809083, 1945.5622484940916, 1977.5945931084166, 2221.7778222177735, 2228.0642130305228, 2254.391314345126, 2143.753468351144, 2176.4014895903515, 2177.0747432341273, 2177.912883484659, 2185.0713446785053, 2287.451011757183, 2288.5308511755215, 2306.238941149417, 2314.4445333120098, 2316.224064938248, 7740.690372385098, 7773.805654858617, 7840.960795196044, 7845.607719613997, 7846.960765196194, 4625.098105869357, 4714.504976977437, 4734.692245004064, 4737.976310118427, 4765.594924431428, 3046.573479712842, 3107.9689203107905, 3158.384115097557, 3173.428782819092, 3194.2333839878493, 1035.9637412690595, 1042.713253855196, 1063.500154927183, 1063.622414043019, 1073.0342691577564, 10852.837207441815, 10923.617673381394, 10935.125189984783, 10961.671149865517, 10984.560617575287, 4134.751914885116, 4136.544980052192, 4152.211079894811, 4178.749275043447, 4199.895002624898, 8733.563321833883, 8758.386912916161, 8782.077881822444, 8797.38418310712, 8809.251213646783, 4562.954370456319, 4585.380973568593, 4591.770411479412, 4596.931046034312, 4608.170529304691, 4261.97869010653, 4313.633341166036, 4320.481542214954, 4321.308590625547, 4327.502337231196, 3414.6756058174433, 3430.382531144418, 3442.1738782691973, 3449.379111759857, 3459.930801383958, 1052.8473371361263, 1077.9137668986461, 1084.6366467233408, 1100.2023532938556, 1105.922585419029, 1027.1269420992246, 1027.6505987963978, 1070.3791800755544, 1279.5073896549895, 1316.9078164528582, 6913.0, 7061.576305421691, 7082.752103676346, 7097.503174777819, 7106.822329441702, 1123.80333441649, 1126.3523474002482, 1130.0846314485293, 1141.3494308244221, 1163.6160067177811, 5910.9655810233035, 5926.703664816742, 5936.495397891142, 5981.132735753292, 5988.550858685616, 9193.68717390124, 9429.717108486757, 9444.433333999981, 9477.763055923657, 9622.855657165148, 9455.763605909908, 9482.0, 9498.050194980586, 9511.762205944768, 9531.761705957406, 6603.438707709803, 6682.63245521501, 6687.0, 6717.966410167918, 7350.448716346295, 7071.328223818729, 7135.357817796424, 7163.820904477429, 7178.138623365021, 7191.0292110564405, 8072.112067672669, 8188.672453101809, 8361.95819020901, 8408.2432581068, 8532.914670853212, 8333.541655209021, 8532.786680333042, 8595.18345757152, 8610.870836937325, 8657.480551166951, 7068.222495525385, 7143.0, 7153.928460715326, 7184.533005354635, 7188.784336469915, 7678.1170165431695, 7709.190534993745, 7712.652930618024, 7743.264389882952, 7760.728374506865, 6478.255000674794, 6890.069840571458, 6932.272111428228, 6956.930430695628, 6969.825754356181, 6709.496787740842, 6713.1944166700305, 7002.929970700432, 7052.823679408056, 7157.1769246537315, 7095.325944035309, 7153.427725781821, 7198.964005179941, 7201.063861697946, 7210.96394518024, 6209.316975132641, 6436.0, 6439.388258115471, 6451.935480645321, 6458.0, 6623.172103487064, 6651.102101216467, 6683.899741503784, 6685.264620891795, 6705.865882682221], "ext.html": [552.7593469726785, 584.2142318581506, 588.2911092133978, 594.5422025040716, 598.3806760003396, 37038.44442333364, 37299.25401491975, 37834.81082594583, 37838.99999999996, 37859.0, 39833.800830995875, 39885.202295954135, 40318.39522407166, 40412.393814092815, 40470.7976460118, 8870.334724895627, 8991.3256505762, 9061.728148155533, 9073.59168837404, 9074.954625226865, 8763.07987661296, 8825.558722063903, 8834.11658834118, 8867.955660221689, 8871.290296776275, 8897.110288971084, 8918.732438026836, 8937.150970657776, 8962.417442866226, 9000.684976025841, 8811.427257228259, 8909.599068041922, 8917.55412229386, 8945.15021072997, 9010.549472526413, 8782.60478278479, 8804.559772011438, 8864.734057978207, 8883.11168883113, 8887.73336799897, 40793.0, 40830.38754418686, 41264.174716505804, 41305.0, 41404.79297603523, 3248.3340915112344, 3273.508973653947, 3273.836308184605, 3287.375398674244, 3296.2748195396975, 29854.0, 30446.84776576103, 30510.54234186489, 30644.38711225763, 31170.376592468252, 3540.8760693375866, 3586.300671369058, 3604.297162053401, 3611.223586928823, 3709.4992176056157, 251977.0, 254157.0, 254716.0, 255380.0, 256239.71880140668, 59455.0, 59763.40236597578, 59794.70102649546, 59857.70071149617, 59923.0, 66906.66546667332, 67671.0, 67871.66064169747, 68113.0, 68175.0, 16199.676006479804, 16362.181890905407, 16460.6707865842, 16492.42276520316, 16526.6694666106, 11866.466009029615, 11968.222065565711, 11994.580189693494, 12000.699982500333, 12061.819072713917, 20851.478713031993, 21131.26040588572, 21259.46851328698, 21287.467813304793, 21294.467638309165, 8304.6678132874, 8526.78683032929, 8591.785205369915, 8592.355573332025, 8666.78333041679, 946.4557879219476, 1007.2093406675724, 1063.7021633942509, 1064.9882611519088, 1129.8474705914762, 29375.17950343173, 29759.85120074386, 30113.247168820955, 33048.50427243593, 33365.0, 1012.2357619996856, 1024.99487502562, 1062.2829590026702, 1089.629525961161, 1120.4061847220985, 14289.56699795223, 14428.350724217435, 14636.487722929647, 14784.186869722269, 14891.255437228096, 723514.0, 740987.0, 744767.0, 745080.0, 748176.0, 55848.72075639596, 56371.15443268354, 56518.43481565214, 56598.0, 56613.0, 1351.6147897849066, 1354.5597680753795, 1361.8978576606794, 1368.2406264523286, 1372.6390608153959, 29765.0, 30460.0, 30659.313737743745, 31221.0, 31340.373192535564, 47569.52430475789, 47702.76148619235, 47940.520594793605, 48278.27582586334, 48322.0, 308349.0, 308822.0, 309890.0, 310154.0, 311571.0, 33845.15387115243, 46752.7662361686, 46927.29609055799, 47474.28788568105, 47566.76216618895, 43201.78399107984, 43939.56060439355, 44045.0, 44047.11905761803, 44109.77945110254, 37138.81430592938, 37151.07122321964, 39628.0, 40791.1841763169, 43297.7835110835, 39889.601103988585, 40053.39919901145, 40749.0, 41145.1770964585, 41982.160356793305, 39485.80257098696, 39611.80194099011, 39834.60165398309, 39891.20217595574, 40084.0, 38815.223695526496, 39870.60129398669, 40231.798841005606, 40388.0, 40809.183816324105, 26826.731732682423, 27405.86297068502, 27412.0, 27440.683013998132, 27491.587626185225], "prototype.html": [330.47124600638966, 332.29884942770764, 337.84627994262615, 341.17605981554544, 351.546505008539, 6297.2128483939505, 6337.873242535153, 6340.841478963028, 6366.936330636692, 6382.170317858672, 6236.875262494747, 6279.874402511947, 6325.0, 6337.841553961153, 6358.777442789503, 4846.709197448146, 4855.223164293714, 4857.8299759508245, 4859.684120532154, 4861.368022157115, 4868.878278043059, 4869.050535145648, 4875.341828853113, 4875.878103047435, 4877.3903262092235, 4739.028499157682, 4814.951850481503, 4817.397825271841, 4818.10864989978, 4831.922273422427, 4817.301491283762, 4821.397325334333, 4823.348847905523, 4829.830955916526, 4841.903161936777, 4054.0878302382025, 4156.9792151039355, 4198.6221240088535, 4200.243956087903, 4263.97868010661, 6028.608140470856, 6041.0, 6041.516678665696, 6042.395760423967, 6071.0, 5594.272744543224, 5601.047821870292, 5608.523275521586, 5614.887702245973, 5623.212750214973, 6586.670666466657, 6720.899186512206, 6729.966350168218, 6732.461403087741, 6738.0, 4613.5847773700525, 4614.930776038362, 4617.215073437524, 4617.37665415168, 4625.306204069383, 6937.653117344163, 6939.6877140528795, 7002.614856182908, 7010.123734533184, 7014.088168538057, 4693.178693728584, 4704.717716936994, 4706.058788242365, 4724.338592597039, 4727.57451829337, 4606.378138951266, 4733.597644200281, 4748.240281554935, 4750.786214620351, 4771.212749896297, 5532.395605274506, 5536.833894983157, 5537.307836520435, 5548.0, 5548.500634942875, 6708.161479815023, 6726.831829204211, 6728.764493242811, 6738.32616738332, 6741.786478433929, 1674.5060207238894, 1696.686113069086, 1698.8471037606676, 1699.3202718912535, 1703.2931333496708, 1090.095220966596, 1098.2916019167592, 1114.0419239454063, 1124.5726623882872, 1125.9155563332783, 6472.611643301417, 6505.51208659343, 6525.575837570637, 6532.869342613121, 6533.869322613521, 6960.060391847137, 6966.233714291424, 6969.965150174318, 6970.825729356705, 6996.0, 6376.7130479128555, 6528.804135875931, 6536.182977127859, 6549.967250163719, 6551.246606640202, 3795.1460921292487, 3798.4872042273937, 3801.6008319126095, 3803.809809509569, 3818.7326887118193, 7152.284771522806, 7344.779656610311, 7356.705731770669, 7365.1530074042175, 7376.815579610446, 7218.422526197892, 7261.128664560181, 7271.018412514243, 7276.308750668678, 7278.199398066208, 7164.749233776897, 7311.670974806147, 7327.523710958771, 7330.523515971551, 7336.963315183497, 7016.894746578908, 7018.438524917892, 7061.611611361219, 7072.504924655224, 7077.5753454792875, 6936.826579335355, 6940.09778728762, 6943.444524437932, 6980.197277313174, 6992.650367481708, 7153.105861767279, 7289.854202916018, 7343.0, 7343.669534871051, 7344.816379590553, 4652.32541281519, 4707.764611769467, 4708.246680531099, 4712.835050773207, 4726.929096063493, 7022.613756243456, 7022.964885175541, 7023.543469674455, 7025.297470252934, 7044.964775176091, 6674.8640435060315, 6745.156855393076, 6838.461346197066, 6839.316068393121, 6847.897281540681, 6815.829604259933, 6818.965905170442, 6820.693068812015, 6821.795346139624, 6830.45356371499, 6645.169353830771, 6658.3674550917585, 6682.064510968371, 6690.665466726741, 6692.598444093175, 6659.367360100783, 6839.350261725327, 6886.001529778054, 6887.829069058373, 6899.793006209822, 6694.866102677822, 6697.062411262525, 6708.262091170065, 6708.295628959084, 6719.5296329258435], "yui.html": [721.9675114619841, 791.1455627921845, 800.951942883427, 814.1654803826082, 827.3174630929483, 13759.380827862746, 14097.859021409782, 14193.503227387044, 14204.928975355122, 14294.499692510764, 12862.48550057999, 12886.904613107898, 12922.28927408992, 12923.547675831347, 13219.735605287888, 808.8341889912554, 821.4126899267023, 827.2596026556229, 827.6358402302998, 837.5686521441462, 804.5172896262225, 832.184459229955, 836.6569706420369, 839.8194388206534, 840.8444437779, 862.1077185113409, 868.6829307302852, 871.4161511787117, 872.9563521823883, 873.1181506678237, 864.8702694595798, 866.2853146154384, 868.7437206024207, 868.9956550217272, 869.2177040663422, 624.4816802054283, 627.5889292513411, 628.8868003759321, 630.8202162383699, 631.6525910749069, 13531.39108740109, 13689.520866769615, 13726.0, 13758.793618095737, 13759.724805503934, 9724.0, 9968.601255949754, 10036.29745917786, 10047.849282260771, 10652.881447447984, 9820.263480239011, 10007.799844003152, 10062.69811905644, 10184.388936663823, 10229.130523905476, 3234.66036066212, 3271.1495011296997, 3298.9278484492634, 3350.061982644839, 3367.96632033679, 47759.761201193774, 47998.28002579929, 48083.03833923337, 48212.27681584779, 48579.757101214265, 7634.847303054019, 7704.614769261514, 7757.069151701832, 7948.046234451903, 8053.1141574426765, 12305.569305074458, 12322.81515777264, 12323.0, 12332.938335308267, 12341.136120471481, 6278.937210627835, 6300.30696623371, 6384.138141350951, 6456.031595260749, 6555.410013098844, 4004.5795191505053, 4044.272031034442, 4051.7974101294817, 4053.61490658387, 4074.124063326399, 2729.9044533441233, 2737.274622225112, 2748.491529067129, 2751.545994910817, 2756.1731480556155, 421.1681928191797, 436.0624656987502, 436.45225242321317, 438.6052552702593, 451.0865497367791, 513.9331886854685, 590.2415396215928, 591.1664552980277, 645.5610185074195, 668.8762578922915, 8244.8351032979, 8518.78703032429, 8655.610497527627, 8764.430312029697, 8778.648854045767, 532.6484520216638, 598.0550729846832, 618.329112912486, 668.8194187569426, 711.7010855440727, 3871.96128038716, 4118.91762164755, 4203.117345357448, 4214.4099826024385, 4224.51418086924, 58053.419465805644, 58678.706606466694, 58755.41244587585, 58869.0, 59402.70298648565, 51203.23195152076, 52167.478325217024, 52418.0, 52445.7377713109, 52765.208521872206, 48017.519824802, 48045.519544804105, 48478.757606211744, 48614.0, 48834.0, 8216.671333146607, 8318.500889946623, 8325.95837020811, 8330.958345208477, 8404.285635721033, 34653.306933861684, 34779.652203478654, 35587.28825423529, 35750.28499429945, 35777.46333805047, 43426.0, 44417.111657766014, 46348.30477542907, 47154.0, 47399.0, 8121.472104313437, 8258.752237432887, 8301.46040507365, 8447.577621119042, 8752.562371881508, 11471.541138354707, 11534.59628912984, 11725.941370293094, 12006.63980080599, 12303.630891073282, 11058.778824423627, 11243.325400475998, 11335.943320283346, 11447.542098315975, 11751.529938802352, 10451.16390688728, 10554.419506927192, 10558.630447934593, 10738.302010369302, 11169.0, 11064.0, 11185.888141118485, 11199.328040317607, 11217.158713096387, 11287.492062857355, 8888.822223555622, 8891.822163556822, 9080.727578172402, 9286.210672092677, 9301.348905576815, 8339.0, 8382.664693412195, 9122.224610907882, 9152.58813353414, 9168.54157292146]}, "summary": {"lowerIsBetter": false, "suite": 6844.677502196431, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6953.05398871165, "unit": "ms", "value": 6953.05398871165}, "dojo.html": {"lowerIsBetter": false, "filtered": 5492.36193784203, "unit": "ms", "value": 5492.36193784203}, "mootools.html": {"lowerIsBetter": false, "filtered": 4475.575422266577, "unit": "ms", "value": 4475.575422266577}, "ext.html": {"lowerIsBetter": false, "filtered": 19805.263206805077, "unit": "ms", "value": 19805.263206805077}, "prototype.html": {"lowerIsBetter": false, "filtered": 5081.217841638429, "unit": "ms", "value": 5081.217841638429}, "yui.html": {"lowerIsBetter": false, "filtered": 5977.89069904806, "unit": "ms", "value": 5977.89069904806}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-061.e"}, "testrun": {"date": 1447781796, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151117073331", "branch": "Mozilla-Inbound", "revision": "f3eb66d21d1ca1e9b140a3052dda40717358562b"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 163.0, 162.0, 163.0, 163.0, 160.0, 163.0, 164.0, 173.0, 163.0], "ai-astar": [112.0, 105.0, 111.0, 110.0, 115.0, 124.0, 111.0, 112.0, 110.0, 112.0], "imaging-gaussian-blur": [111.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0], "audio-beat-detection": [162.0, 129.0, 149.0, 159.0, 125.0, 153.0, 153.0, 127.0, 162.0, 126.0], "json-stringify-tinderbox": [69.0, 69.0, 69.0, 70.0, 70.0, 70.0, 69.0, 71.0, 69.0, 70.0], "stanford-crypto-pbkdf2": [139.0, 147.0, 155.0, 150.0, 151.0, 139.0, 146.0, 151.0, 150.0, 152.0], "json-parse-financial": [62.0, 61.0, 64.0, 62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 60.0], "stanford-crypto-sha256-iterative": [70.0, 66.0, 68.0, 68.0, 70.0, 66.0, 66.0, 67.0, 65.0, 66.0], "audio-fft": [73.0, 77.0, 71.0, 74.0, 73.0, 135.0, 83.0, 71.0, 73.0, 72.0], "imaging-darkroom": [147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0], "stanford-crypto-ccm": [125.0, 123.0, 133.0, 116.0, 131.0, 133.0, 118.0, 124.0, 121.0, 118.0], "audio-oscillator": [91.0, 91.0, 138.0, 91.0, 91.0, 90.0, 141.0, 90.0, 90.0, 128.0], "stanford-crypto-aes": [85.0, 94.0, 90.0, 86.0, 86.0, 84.0, 85.0, 87.0, 85.0, 86.0], "imaging-desaturate": [97.0, 98.0, 96.0, 97.0, 96.0, 98.0, 96.0, 97.0, 98.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1515.9999999999998, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 80.2, "unit": "ms", "value": 80.2}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 148.0, "unit": "ms", "value": 148.0}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 144.5, "unit": "ms", "value": 144.5}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 124.2, "unit": "ms", "value": 124.2}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 146.6, "unit": "ms", "value": 146.6}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 61.8, "unit": "ms", "value": 61.8}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 104.1, "unit": "ms", "value": 104.1}, "ai-astar": {"lowerIsBetter": true, "filtered": 112.2, "unit": "ms", "value": 112.2}, "audio-dft": {"lowerIsBetter": true, "filtered": 163.6, "unit": "ms", "value": 163.6}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 67.2, "unit": "ms", "value": 67.2}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.6, "unit": "ms", "value": 69.6}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 110.3, "unit": "ms", "value": 110.3}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 86.8, "unit": "ms", "value": 86.8}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.9, "unit": "ms", "value": 96.9}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-061.e"}, "testrun": {"date": 1447781796, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151117073331", "branch": "Mozilla-Inbound", "revision": "f3eb66d21d1ca1e9b140a3052dda40717358562b"}}, {"talos_counters": {}, "results": {"DeltaBlue": [189.64536317087047], "Encrypt": [280.0336040324839], "NavierStokes": [4830.917874396136], "Decrypt": [5086.294416243655], "Splay": [651.5249837767683], "Richards": [166.16816218012627], "RegExp": [25075.0], "Earley": [715.8196134574088], "Boyer": [12096.385542168675], "RayTrace": [1055.9662090813094]}, "summary": {"lowerIsBetter": false, "suite": 21301.35495736409, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 348.64021400000007, "unit": "score", "value": 348.64021400000007}, "Encrypt": {"lowerIsBetter": false, "filtered": 950.5323509999997, "unit": "score", "value": 950.5323509999997}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.1879999999999, "unit": "score", "value": 307.1879999999999}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.33299101796402, "unit": "score", "value": 52.33299101796402}, "Splay": {"lowerIsBetter": false, "filtered": 125.07732171314746, "unit": "score", "value": 125.07732171314746}, "RegExp": {"lowerIsBetter": false, "filtered": 36.33040877367896, "unit": "score", "value": 36.33040877367896}, "Richards": {"lowerIsBetter": false, "filtered": 212.4474360000001, "unit": "score", "value": 212.4474360000001}, "Earley": {"lowerIsBetter": false, "filtered": 931.0488110000001, "unit": "score", "value": 931.0488110000001}, "Boyer": {"lowerIsBetter": false, "filtered": 55.096044820717125, "unit": "score", "value": 55.096044820717125}, "RayTrace": {"lowerIsBetter": false, "filtered": 700.7695829999997, "unit": "score", "value": 700.7695829999997}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-061.e"}, "testrun": {"date": 1447781796, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151117073331", "branch": "Mozilla-Inbound", "revision": "f3eb66d21d1ca1e9b140a3052dda40717358562b"}}] 09:56:45 INFO - RETURN: dromaeo_css: 6844.68 09:56:45 INFO - RETURN: kraken: 1516.00 09:56:45 INFO - RETURN: v8_7: 21301.35 09:56:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21301.35"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1516.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6844.68"}}} 09:56:45 INFO - Return code: 0 09:56:45 INFO - # TBPL SUCCESS # 09:56:45 INFO - Running post-action listener: _resource_record_post_action 09:56:45 INFO - Running post-run listener: _resource_record_post_run 09:56:46 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 28672; Write bytes: 520179712; Read time: 376; Write time: 460828 09:56:46 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 4096; Write bytes: 238010368; Read time: 180; Write time: 317984 09:56:46 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 24576; Write bytes: 282169344; Read time: 196; Write time: 142844 09:56:46 INFO - Running post-run listener: _upload_blobber_files 09:56:46 INFO - Blob upload gear active. 09:56:46 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:56:46 INFO - Copying logs to upload dir... 09:56:46 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1252.811120 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2015-11-17 09:56:46.575939) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 09:56:46.579712) ========= 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=5804b9f07a53938c557deee7000001c5-1447778624.856714-1849539176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009944 build_url: 'https://queue.taskcluster.net/v1/task/i_tV8gIRRvq2cUX8OKqRLw/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-17 09:56:46.631884) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:56:46.632276) ========= 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=5804b9f07a53938c557deee7000001c5-1447778624.856714-1849539176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004723 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:56:46.682800) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 09:56:46.683175) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 09:56:46.683518) ========= ========= Total master_lag: 0.18 =========