builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-037 starttime: 1447696171.37 results: success (0) buildid: 20151116073034 builduid: 0559e68bae7747daadc9b9097596ee8c revision: 4294bf91174b71ed7440dc491dac5d15394ec227 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 09:49:31.372149) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 09:49:31.372587) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 09:49:31.372894) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1447692795.66995-1538703239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006689 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 09:49:31.395006) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 09:49:31.395310) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 09:49:31.419611) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 09:49:31.419964) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1447692795.66995-1538703239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023281 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 09:49:31.466626) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 09:49:31.466947) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 09:49:31.467322) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 09:49:31.467600) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1447692795.66995-1538703239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-16 09:49:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2015-11-16 09:49:31 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131960 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 09:49:31.611911) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 09:49:31.612199) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1447692795.66995-1538703239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.093754 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 09:49:31.716041) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-16 09:49:31.716404) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4294bf91174b71ed7440dc491dac5d15394ec227 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 4294bf91174b71ed7440dc491dac5d15394ec227 --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=6ea65ccfe4e6b94e0d4f826f000001d8-1447692795.66995-1538703239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-16 09:49:31,913 truncating revision to first 12 chars 2015-11-16 09:49:31,913 Setting DEBUG logging. 2015-11-16 09:49:31,913 attempt 1/10 2015-11-16 09:49:31,913 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4294bf91174b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 09:49:33,350 unpacking tar archive at: mozilla-central-4294bf91174b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.725831 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-16 09:49:33.455555) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 09:49:33.455888) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 09:49:33.465787) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 09:49:33.466108) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 09:49:33.466570) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2015-11-16 09:49:33.466885) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=6ea65ccfe4e6b94e0d4f826f000001d8-1447692795.66995-1538703239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:49:33 INFO - MultiFileLogger online at 20151116 09:49:33 in /builds/slave/test-pgo 09:49:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:49:33 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:49:33 INFO - {'append_to_log': False, 09:49:33 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:49:33 INFO - 'blob_upload_branch': 'Firefox', 09:49:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:49:33 INFO - 'branch': 'Firefox', 09:49:33 INFO - 'buildbot_json_path': 'buildprops.json', 09:49:33 INFO - 'config_files': ('talos/linux_config.py',), 09:49:33 INFO - 'default_actions': ('clobber', 09:49:33 INFO - 'read-buildbot-config', 09:49:33 INFO - 'download-and-extract', 09:49:33 INFO - 'populate-webroot', 09:49:33 INFO - 'create-virtualenv', 09:49:33 INFO - 'install', 09:49:33 INFO - 'run-tests'), 09:49:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:49:33 INFO - 'download_minidump_stackwalk': True, 09:49:33 INFO - 'download_symbols': 'ondemand', 09:49:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:49:33 INFO - 'tooltool.py': '/tools/tooltool.py', 09:49:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:49:33 INFO - '/tools/misc-python/virtualenv.py')}, 09:49:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:49:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:49:33 INFO - 'installer_path': 'installer.exe', 09:49:33 INFO - 'log_level': 'info', 09:49:33 INFO - 'log_name': 'talos', 09:49:33 INFO - 'log_to_console': True, 09:49:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:49:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:49:33 INFO - 'opt_config_files': (), 09:49:33 INFO - 'pip_index': False, 09:49:33 INFO - 'sps_profile': False, 09:49:33 INFO - 'sps_profile_interval': 0, 09:49:33 INFO - 'suite': 'dromaeojs-e10s', 09:49:33 INFO - 'system_bits': '64', 09:49:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:49:33 INFO - 'title': 'talos-linux64-ix-037', 09:49:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:49:33 INFO - 'use_talos_json': True, 09:49:33 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:49:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:49:33 INFO - 'work_dir': 'build'} 09:49:33 INFO - ##### 09:49:33 INFO - ##### Running clobber step. 09:49:33 INFO - ##### 09:49:33 INFO - Running pre-action listener: _resource_record_pre_action 09:49:33 INFO - Running main action method: clobber 09:49:33 INFO - rmtree: /builds/slave/test-pgo/build 09:49:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:49:34 INFO - Running post-action listener: _resource_record_post_action 09:49:34 INFO - ##### 09:49:34 INFO - ##### Running read-buildbot-config step. 09:49:34 INFO - ##### 09:49:34 INFO - Running pre-action listener: _resource_record_pre_action 09:49:34 INFO - Running main action method: read_buildbot_config 09:49:34 INFO - Using buildbot properties: 09:49:34 INFO - { 09:49:34 INFO - "properties": { 09:49:34 INFO - "buildnumber": 244, 09:49:34 INFO - "product": "firefox", 09:49:34 INFO - "script_repo_revision": "production", 09:49:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:49:34 INFO - "repository": "", 09:49:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 09:49:34 INFO - "buildid": "20151116073034", 09:49:34 INFO - "slavename": "talos-linux64-ix-037", 09:49:34 INFO - "pgo_build": "True", 09:49:34 INFO - "basedir": "/builds/slave/test-pgo", 09:49:34 INFO - "project": "", 09:49:34 INFO - "platform": "ubuntu64_hw", 09:49:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:49:34 INFO - "slavebuilddir": "test", 09:49:34 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 09:49:34 INFO - "branch": "mozilla-central", 09:49:34 INFO - "repo_path": "mozilla-central", 09:49:34 INFO - "stage_platform": "linux64-pgo", 09:49:34 INFO - "builduid": "0559e68bae7747daadc9b9097596ee8c", 09:49:34 INFO - "revision": "4294bf91174b71ed7440dc491dac5d15394ec227" 09:49:34 INFO - }, 09:49:34 INFO - "sourcestamp": { 09:49:34 INFO - "repository": "", 09:49:34 INFO - "hasPatch": false, 09:49:34 INFO - "project": "", 09:49:34 INFO - "branch": "mozilla-central-linux64-pgo-talos", 09:49:34 INFO - "changes": [ 09:49:34 INFO - { 09:49:34 INFO - "category": null, 09:49:34 INFO - "files": [ 09:49:34 INFO - { 09:49:34 INFO - "url": null, 09:49:34 INFO - "name": "https://queue.taskcluster.net/v1/task/FBWy8FvOTJaUdxdmhI5i3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:49:34 INFO - } 09:49:34 INFO - ], 09:49:34 INFO - "repository": "", 09:49:34 INFO - "rev": "4294bf91174b71ed7440dc491dac5d15394ec227", 09:49:34 INFO - "who": "sendchange", 09:49:34 INFO - "when": 1447696059, 09:49:34 INFO - "number": 6666928, 09:49:34 INFO - "comments": "", 09:49:34 INFO - "project": "", 09:49:34 INFO - "at": "Mon 16 Nov 2015 09:47:39", 09:49:34 INFO - "branch": "mozilla-central-linux64-pgo-talos", 09:49:34 INFO - "revlink": "", 09:49:34 INFO - "properties": [ 09:49:34 INFO - [ 09:49:34 INFO - "buildid", 09:49:34 INFO - "20151116073034", 09:49:34 INFO - "Change" 09:49:34 INFO - ], 09:49:34 INFO - [ 09:49:34 INFO - "builduid", 09:49:34 INFO - "0559e68bae7747daadc9b9097596ee8c", 09:49:34 INFO - "Change" 09:49:34 INFO - ], 09:49:34 INFO - [ 09:49:34 INFO - "pgo_build", 09:49:34 INFO - "True", 09:49:34 INFO - "Change" 09:49:34 INFO - ] 09:49:34 INFO - ], 09:49:34 INFO - "revision": "4294bf91174b71ed7440dc491dac5d15394ec227" 09:49:34 INFO - } 09:49:34 INFO - ], 09:49:34 INFO - "revision": "4294bf91174b71ed7440dc491dac5d15394ec227" 09:49:34 INFO - } 09:49:34 INFO - } 09:49:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/FBWy8FvOTJaUdxdmhI5i3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:49:34 INFO - Running post-action listener: _resource_record_post_action 09:49:34 INFO - ##### 09:49:34 INFO - ##### Running download-and-extract step. 09:49:34 INFO - ##### 09:49:34 INFO - Running pre-action listener: _resource_record_pre_action 09:49:34 INFO - Running main action method: download_and_extract 09:49:34 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:34 INFO - https://queue.taskcluster.net/v1/task/FBWy8FvOTJaUdxdmhI5i3A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:49:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBWy8FvOTJaUdxdmhI5i3A/artifacts/public/build/test_packages.json 09:49:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBWy8FvOTJaUdxdmhI5i3A/artifacts/public/build/test_packages.json 09:49:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBWy8FvOTJaUdxdmhI5i3A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:49:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBWy8FvOTJaUdxdmhI5i3A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:49:36 INFO - Downloaded 1302 bytes. 09:49:36 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:49:36 INFO - Using the following test package requirements: 09:49:36 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:49:36 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:49:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:49:36 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:49:36 INFO - u'jsshell-linux-x86_64.zip'], 09:49:36 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:49:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:49:36 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:49:36 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:49:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:49:36 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:49:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:49:36 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:49:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:49:36 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:49:36 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:49:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:49:36 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:36 INFO - https://queue.taskcluster.net/v1/task/FBWy8FvOTJaUdxdmhI5i3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:49:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBWy8FvOTJaUdxdmhI5i3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:49:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBWy8FvOTJaUdxdmhI5i3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:49:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBWy8FvOTJaUdxdmhI5i3A/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:49:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBWy8FvOTJaUdxdmhI5i3A/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:49:37 INFO - Downloaded 22462131 bytes. 09:49:37 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:49:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:49:37 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:49:38 INFO - Return code: 0 09:49:38 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:49:38 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:49:38 INFO - https://queue.taskcluster.net/v1/task/FBWy8FvOTJaUdxdmhI5i3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:49:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBWy8FvOTJaUdxdmhI5i3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:49:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBWy8FvOTJaUdxdmhI5i3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:49:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBWy8FvOTJaUdxdmhI5i3A/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:49:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBWy8FvOTJaUdxdmhI5i3A/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:49:41 INFO - Downloaded 22462131 bytes. 09:49:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 09:49:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:49:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:49:42 INFO - Return code: 0 09:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:42 INFO - https://queue.taskcluster.net/v1/task/FBWy8FvOTJaUdxdmhI5i3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:49:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBWy8FvOTJaUdxdmhI5i3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:49:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBWy8FvOTJaUdxdmhI5i3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:49:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBWy8FvOTJaUdxdmhI5i3A/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:49:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBWy8FvOTJaUdxdmhI5i3A/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:49:43 INFO - Downloaded 11131693 bytes. 09:49:43 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:49:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:49:43 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:49:43 INFO - Return code: 0 09:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:43 INFO - https://queue.taskcluster.net/v1/task/FBWy8FvOTJaUdxdmhI5i3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:49:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBWy8FvOTJaUdxdmhI5i3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:49:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBWy8FvOTJaUdxdmhI5i3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:49:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBWy8FvOTJaUdxdmhI5i3A/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:49:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBWy8FvOTJaUdxdmhI5i3A/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:49:45 INFO - Downloaded 57142738 bytes. 09:49:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FBWy8FvOTJaUdxdmhI5i3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:49:45 INFO - mkdir: /builds/slave/test-pgo/properties 09:49:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:49:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:49:45 INFO - Contents: 09:49:45 INFO - build_url:https://queue.taskcluster.net/v1/task/FBWy8FvOTJaUdxdmhI5i3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:49:45 INFO - Running post-action listener: _resource_record_post_action 09:49:45 INFO - Running post-action listener: set_extra_try_arguments 09:49:45 INFO - ##### 09:49:45 INFO - ##### Running populate-webroot step. 09:49:45 INFO - ##### 09:49:45 INFO - Running pre-action listener: _resource_record_pre_action 09:49:45 INFO - Running main action method: populate_webroot 09:49:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:49:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:49:45 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:49:45 INFO - '../fennec_ids.txt'], 09:49:45 INFO - 'tests': ['tcheck2']}, 09:49:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:49:45 INFO - '--tppagecycles', 09:49:45 INFO - '7'], 09:49:45 INFO - 'tests': ['tsvgm']}}, 09:49:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:49:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:49:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:49:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:49:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:49:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:49:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:49:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:45 INFO - 'talos_options': ['--e10s'], 09:49:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:49:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:45 INFO - 'tests': ['damp', 'tps']}, 09:49:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:45 INFO - 'talos_options': ['--e10s'], 09:49:45 INFO - 'tests': ['damp', 'tps']}, 09:49:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:49:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:49:45 INFO - 'other': {'tests': ['a11yr', 09:49:45 INFO - 'ts_paint', 09:49:45 INFO - 'tpaint', 09:49:45 INFO - 'sessionrestore', 09:49:45 INFO - 'sessionrestore_no_auto_restore']}, 09:49:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:49:45 INFO - 'tests': ['a11yr', 09:49:45 INFO - 'ts_paint', 09:49:45 INFO - 'tpaint', 09:49:45 INFO - 'sessionrestore', 09:49:45 INFO - 'sessionrestore_no_auto_restore']}, 09:49:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:49:45 INFO - 'tests': ['a11yr', 09:49:45 INFO - 'ts_paint', 09:49:45 INFO - 'tpaint', 09:49:45 INFO - 'sessionrestore', 09:49:45 INFO - 'sessionrestore_no_auto_restore']}, 09:49:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:49:45 INFO - 'tests': ['a11yr', 09:49:45 INFO - 'ts_paint', 09:49:45 INFO - 'tpaint', 09:49:45 INFO - 'sessionrestore', 09:49:45 INFO - 'sessionrestore_no_auto_restore']}, 09:49:45 INFO - 'other_l64': {'tests': ['a11yr', 09:49:45 INFO - 'ts_paint', 09:49:45 INFO - 'tpaint', 09:49:45 INFO - 'sessionrestore', 09:49:45 INFO - 'sessionrestore_no_auto_restore']}, 09:49:45 INFO - 'other_nol64': {'tests': ['a11yr', 09:49:45 INFO - 'ts_paint', 09:49:45 INFO - 'tpaint', 09:49:45 INFO - 'sessionrestore', 09:49:45 INFO - 'sessionrestore_no_auto_restore']}, 09:49:45 INFO - 'svgr': {'tests': ['tsvgx', 09:49:45 INFO - 'tsvgr_opacity', 09:49:45 INFO - 'tart', 09:49:45 INFO - 'tscrollx', 09:49:45 INFO - 'cart']}, 09:49:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:49:45 INFO - 'tests': ['tsvgx', 09:49:45 INFO - 'tsvgr_opacity', 09:49:45 INFO - 'tart', 09:49:45 INFO - 'tscrollx', 09:49:45 INFO - 'cart']}, 09:49:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:45 INFO - 'tests': ['tp5o']}, 09:49:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:45 INFO - 'talos_options': ['--e10s'], 09:49:45 INFO - 'tests': ['tp5o']}, 09:49:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:45 INFO - 'talos_options': ['--xperf_path', 09:49:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:49:45 INFO - 'tests': ['tp5n']}, 09:49:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:45 INFO - 'talos_options': ['--e10s', 09:49:45 INFO - '--xperf_path', 09:49:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:49:45 INFO - 'tests': ['tp5n']}}, 09:49:45 INFO - 'talos.zip': {'path': '', 09:49:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:49:45 INFO - Running post-action listener: _resource_record_post_action 09:49:45 INFO - ##### 09:49:45 INFO - ##### Running create-virtualenv step. 09:49:45 INFO - ##### 09:49:45 INFO - Running pre-action listener: _resource_record_pre_action 09:49:45 INFO - Running main action method: create_virtualenv 09:49:45 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:49:45 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:49:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:49:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:49:45 INFO - Using real prefix '/usr' 09:49:45 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:49:45 INFO - Installing distribute.............................................................................................................................................................................................done. 09:49:47 INFO - Installing pip.................done. 09:49:47 INFO - Return code: 0 09:49:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:49:47 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:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:47 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:49:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:47 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 0x7ff068368c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e436c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f043d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d8c0>, '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 0x1f3a420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3a8b0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1447692795.66995-1538703239', '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:49:47 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:49:47 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:49:47 INFO - Using env: {'DISPLAY': ':0', 09:49:47 INFO - 'HOME': '/home/cltbld', 09:49:47 INFO - 'LANG': 'en_US.UTF-8', 09:49:47 INFO - 'LANGUAGE': 'en_US:en', 09:49:47 INFO - 'LOGNAME': 'cltbld', 09:49:47 INFO - 'MAIL': '/var/mail/cltbld', 09:49:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:47 INFO - 'MOZ_NO_REMOTE': '1', 09:49:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:47 INFO - 'NO_EM_RESTART': '1', 09:49:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:47 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:47 INFO - 'SHELL': '/bin/bash', 09:49:47 INFO - 'SHLVL': '1', 09:49:47 INFO - 'TERM': 'linux', 09:49:47 INFO - 'TMOUT': '86400', 09:49:47 INFO - 'USER': 'cltbld', 09:49:47 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1447692795.66995-1538703239', 09:49:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:47 INFO - '_': '/tools/buildbot/bin/python'} 09:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:48 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:49:48 INFO - Cleaning up... 09:49:48 INFO - Return code: 0 09:49:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:48 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 0x7ff068368c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e436c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f043d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d8c0>, '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 0x1f3a420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3a8b0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1447692795.66995-1538703239', '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:49:48 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:49:48 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:49:48 INFO - Using env: {'DISPLAY': ':0', 09:49:48 INFO - 'HOME': '/home/cltbld', 09:49:48 INFO - 'LANG': 'en_US.UTF-8', 09:49:48 INFO - 'LANGUAGE': 'en_US:en', 09:49:48 INFO - 'LOGNAME': 'cltbld', 09:49:48 INFO - 'MAIL': '/var/mail/cltbld', 09:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:48 INFO - 'MOZ_NO_REMOTE': '1', 09:49:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:48 INFO - 'NO_EM_RESTART': '1', 09:49:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:48 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:48 INFO - 'SHELL': '/bin/bash', 09:49:48 INFO - 'SHLVL': '1', 09:49:48 INFO - 'TERM': 'linux', 09:49:48 INFO - 'TMOUT': '86400', 09:49:48 INFO - 'USER': 'cltbld', 09:49:48 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1447692795.66995-1538703239', 09:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:48 INFO - '_': '/tools/buildbot/bin/python'} 09:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:48 INFO - Downloading/unpacking psutil>=0.7.1 09:49:48 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:49:48 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:49:48 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:49:48 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:49:48 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:49:48 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:49:49 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 09:49:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:49:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:49:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:49:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:49:50 INFO - Installing collected packages: psutil 09:49:50 INFO - Running setup.py install for psutil 09:49:50 INFO - building 'psutil._psutil_linux' extension 09:49:50 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:49:50 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:49:50 INFO - building 'psutil._psutil_posix' extension 09:49:50 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:49:50 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:49:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:49:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:49:50 INFO - Successfully installed psutil 09:49:50 INFO - Cleaning up... 09:49:50 INFO - Return code: 0 09:49:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:49:50 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:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:50 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:49:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:50 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 0x7ff068368c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e436c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f043d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d8c0>, '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 0x1f3a420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3a8b0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1447692795.66995-1538703239', '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:49:50 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:49:50 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:49:50 INFO - Using env: {'DISPLAY': ':0', 09:49:50 INFO - 'HOME': '/home/cltbld', 09:49:50 INFO - 'LANG': 'en_US.UTF-8', 09:49:50 INFO - 'LANGUAGE': 'en_US:en', 09:49:50 INFO - 'LOGNAME': 'cltbld', 09:49:50 INFO - 'MAIL': '/var/mail/cltbld', 09:49:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:50 INFO - 'MOZ_NO_REMOTE': '1', 09:49:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:50 INFO - 'NO_EM_RESTART': '1', 09:49:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:50 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:50 INFO - 'SHELL': '/bin/bash', 09:49:50 INFO - 'SHLVL': '1', 09:49:50 INFO - 'TERM': 'linux', 09:49:50 INFO - 'TMOUT': '86400', 09:49:50 INFO - 'USER': 'cltbld', 09:49:50 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1447692795.66995-1538703239', 09:49:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:50 INFO - '_': '/tools/buildbot/bin/python'} 09:49:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:49:50 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:49:50 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:49:50 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:49:50 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:49:50 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:49:50 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:49:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:49:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:49:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:49:52 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:49:52 INFO - Installing collected packages: mozsystemmonitor 09:49:52 INFO - Running setup.py install for mozsystemmonitor 09:49:52 INFO - Successfully installed mozsystemmonitor 09:49:52 INFO - Cleaning up... 09:49:52 INFO - Return code: 0 09:49:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff068368c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e436c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f043d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d8c0>, '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 0x1f3a420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3a8b0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1447692795.66995-1538703239', '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:49:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 09:49:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:49:52 INFO - Using env: {'DISPLAY': ':0', 09:49:52 INFO - 'HOME': '/home/cltbld', 09:49:52 INFO - 'LANG': 'en_US.UTF-8', 09:49:52 INFO - 'LANGUAGE': 'en_US:en', 09:49:52 INFO - 'LOGNAME': 'cltbld', 09:49:52 INFO - 'MAIL': '/var/mail/cltbld', 09:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:52 INFO - 'MOZ_NO_REMOTE': '1', 09:49:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:52 INFO - 'NO_EM_RESTART': '1', 09:49:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:52 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:52 INFO - 'SHELL': '/bin/bash', 09:49:52 INFO - 'SHLVL': '1', 09:49:52 INFO - 'TERM': 'linux', 09:49:52 INFO - 'TMOUT': '86400', 09:49:52 INFO - 'USER': 'cltbld', 09:49:52 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1447692795.66995-1538703239', 09:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:52 INFO - '_': '/tools/buildbot/bin/python'} 09:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:52 INFO - Downloading/unpacking blobuploader==1.2.4 09:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:54 INFO - Downloading blobuploader-1.2.4.tar.gz 09:49:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:49:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:49:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:49:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:49:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:49:55 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:49:55 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:49:55 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:49:55 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:49:55 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:49:55 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:49:55 INFO - Downloading docopt-0.6.1.tar.gz 09:49:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:49:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:49:55 INFO - Installing collected packages: blobuploader, requests, docopt 09:49:55 INFO - Running setup.py install for blobuploader 09:49:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:49:55 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:49:55 INFO - Running setup.py install for requests 09:49:55 INFO - Running setup.py install for docopt 09:49:56 INFO - Successfully installed blobuploader requests docopt 09:49:56 INFO - Cleaning up... 09:49:56 INFO - Return code: 0 09:49:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:49:56 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:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:56 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:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:56 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 0x7ff068368c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e436c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f043d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d8c0>, '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 0x1f3a420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3a8b0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1447692795.66995-1538703239', '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:49:56 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:49:56 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:49:56 INFO - Using env: {'DISPLAY': ':0', 09:49:56 INFO - 'HOME': '/home/cltbld', 09:49:56 INFO - 'LANG': 'en_US.UTF-8', 09:49:56 INFO - 'LANGUAGE': 'en_US:en', 09:49:56 INFO - 'LOGNAME': 'cltbld', 09:49:56 INFO - 'MAIL': '/var/mail/cltbld', 09:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:56 INFO - 'MOZ_NO_REMOTE': '1', 09:49:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:56 INFO - 'NO_EM_RESTART': '1', 09:49:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:56 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:56 INFO - 'SHELL': '/bin/bash', 09:49:56 INFO - 'SHLVL': '1', 09:49:56 INFO - 'TERM': 'linux', 09:49:56 INFO - 'TMOUT': '86400', 09:49:56 INFO - 'USER': 'cltbld', 09:49:56 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1447692795.66995-1538703239', 09:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:56 INFO - '_': '/tools/buildbot/bin/python'} 09:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:49:56 INFO - Running setup.py (path:/tmp/pip-3yY6YQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:49:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:49:56 INFO - Running setup.py (path:/tmp/pip-PKOwB1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:49:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:49:56 INFO - Running setup.py (path:/tmp/pip-iMynfT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:49:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:49:56 INFO - Running setup.py (path:/tmp/pip-fP58HI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:49:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:49:56 INFO - Running setup.py (path:/tmp/pip-FeE5aw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:49:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:49:56 INFO - Running setup.py (path:/tmp/pip-uOCWg5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:49:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:49:56 INFO - Running setup.py (path:/tmp/pip-fk3hUv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:49:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:49:56 INFO - Running setup.py (path:/tmp/pip-BLGmPH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:49:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:49:56 INFO - Running setup.py (path:/tmp/pip-5dOuww-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:49:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:49:56 INFO - Running setup.py (path:/tmp/pip-Irs6Bv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:49:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:49:56 INFO - Running setup.py (path:/tmp/pip-utziAB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:49:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:49:57 INFO - Running setup.py (path:/tmp/pip-rPwcQX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:49:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:49:57 INFO - Running setup.py (path:/tmp/pip-4RfwhW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:49:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:49:57 INFO - Running setup.py (path:/tmp/pip-Jhh585-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:49:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:49:57 INFO - Running setup.py (path:/tmp/pip-NVX4Dm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:49:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:49:57 INFO - Running setup.py (path:/tmp/pip-0U7ezb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:49:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:49:57 INFO - Running setup.py (path:/tmp/pip-UVjxzO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:49:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:49:57 INFO - Running setup.py install for manifestparser 09:49:57 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:49:57 INFO - Running setup.py install for mozcrash 09:49:57 INFO - Running setup.py install for mozdebug 09:49:57 INFO - Running setup.py install for mozdevice 09:49:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:49:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:49:57 INFO - Running setup.py install for mozfile 09:49:58 INFO - Running setup.py install for mozhttpd 09:49:58 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:49:58 INFO - Running setup.py install for mozinfo 09:49:58 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:49:58 INFO - Running setup.py install for mozInstall 09:49:58 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:49:58 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:49:58 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:49:58 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:49:58 INFO - Running setup.py install for mozleak 09:49:58 INFO - Running setup.py install for mozlog 09:49:58 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:49:58 INFO - Running setup.py install for moznetwork 09:49:58 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:49:58 INFO - Running setup.py install for mozprocess 09:49:58 INFO - Running setup.py install for mozprofile 09:49:58 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:49:58 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:49:58 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:49:58 INFO - Running setup.py install for mozrunner 09:49:58 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:49:58 INFO - Running setup.py install for mozscreenshot 09:49:59 INFO - Running setup.py install for moztest 09:49:59 INFO - Running setup.py install for mozversion 09:49:59 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:49:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:49:59 INFO - Cleaning up... 09:49:59 INFO - Return code: 0 09:49:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7ff068368c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e436c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f043d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d8c0>, '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 0x1f3a420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3a8b0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1447692795.66995-1538703239', '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:49:59 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:49:59 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:49:59 INFO - Using env: {'DISPLAY': ':0', 09:49:59 INFO - 'HOME': '/home/cltbld', 09:49:59 INFO - 'LANG': 'en_US.UTF-8', 09:49:59 INFO - 'LANGUAGE': 'en_US:en', 09:49:59 INFO - 'LOGNAME': 'cltbld', 09:49:59 INFO - 'MAIL': '/var/mail/cltbld', 09:49:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:59 INFO - 'MOZ_NO_REMOTE': '1', 09:49:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:59 INFO - 'NO_EM_RESTART': '1', 09:49:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:59 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:59 INFO - 'SHELL': '/bin/bash', 09:49:59 INFO - 'SHLVL': '1', 09:49:59 INFO - 'TERM': 'linux', 09:49:59 INFO - 'TMOUT': '86400', 09:49:59 INFO - 'USER': 'cltbld', 09:49:59 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1447692795.66995-1538703239', 09:49:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:59 INFO - '_': '/tools/buildbot/bin/python'} 09:49:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:49:59 INFO - Running setup.py (path:/tmp/pip-v66Gtw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:49:59 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:49:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:49:59 INFO - Running setup.py (path:/tmp/pip-Qz19hM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:49:59 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:49:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:49:59 INFO - Running setup.py (path:/tmp/pip-JpYDhp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:49:59 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:49:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:49:59 INFO - Running setup.py (path:/tmp/pip-VnUxAq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:49:59 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:49:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:49:59 INFO - Running setup.py (path:/tmp/pip-pIwyvB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:49:59 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:49:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:49:59 INFO - Running setup.py (path:/tmp/pip-NXTO33-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:49:59 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:49:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:49:59 INFO - Running setup.py (path:/tmp/pip-_zUj38-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:49:59 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:49:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:49:59 INFO - Running setup.py (path:/tmp/pip-aGvo5g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:50:00 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:50:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:50:00 INFO - Running setup.py (path:/tmp/pip-khWqMJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:50:00 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:50:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:50:00 INFO - Running setup.py (path:/tmp/pip-Lmdt0D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:50:00 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:50:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:50:00 INFO - Running setup.py (path:/tmp/pip-69dI_w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:50:00 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:50:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:50:00 INFO - Running setup.py (path:/tmp/pip-LO9pZk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:50:00 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:50:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:50:00 INFO - Running setup.py (path:/tmp/pip-eg4fGZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:50:00 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:50:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:50:00 INFO - Running setup.py (path:/tmp/pip-_DlB44-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:50:00 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:50:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:50:00 INFO - Running setup.py (path:/tmp/pip-IgbuB4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:50:00 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:50:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:50:00 INFO - Running setup.py (path:/tmp/pip-OSsT04-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:50:00 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:50:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:50:00 INFO - Running setup.py (path:/tmp/pip-XIiGIw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:50:00 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:50:00 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:50:00 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:50:00 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:50:00 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:50:00 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:50:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:02 INFO - Downloading blessings-1.5.1.tar.gz 09:50:02 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:50:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:50:02 INFO - Installing collected packages: blessings 09:50:02 INFO - Running setup.py install for blessings 09:50:02 INFO - Successfully installed blessings 09:50:02 INFO - Cleaning up... 09:50:02 INFO - Return code: 0 09:50:02 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:50:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:50:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:50:02 INFO - Reading from file tmpfile_stdout 09:50:02 INFO - Current package versions: 09:50:02 INFO - argparse == 1.2.1 09:50:02 INFO - blessings == 1.5.1 09:50:02 INFO - blobuploader == 1.2.4 09:50:02 INFO - docopt == 0.6.1 09:50:02 INFO - manifestparser == 1.1 09:50:02 INFO - mozInstall == 1.12 09:50:02 INFO - mozcrash == 0.16 09:50:02 INFO - mozdebug == 0.1 09:50:02 INFO - mozdevice == 0.47 09:50:02 INFO - mozfile == 1.2 09:50:02 INFO - mozhttpd == 0.7 09:50:02 INFO - mozinfo == 0.9 09:50:02 INFO - mozleak == 0.1 09:50:02 INFO - mozlog == 3.0 09:50:02 INFO - moznetwork == 0.27 09:50:02 INFO - mozprocess == 0.22 09:50:02 INFO - mozprofile == 0.27 09:50:02 INFO - mozrunner == 6.11 09:50:02 INFO - mozscreenshot == 0.1 09:50:02 INFO - mozsystemmonitor == 0.0 09:50:02 INFO - moztest == 0.7 09:50:02 INFO - mozversion == 1.4 09:50:02 INFO - psutil == 3.1.1 09:50:02 INFO - requests == 1.2.3 09:50:02 INFO - wsgiref == 0.1.2 09:50:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:50: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:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50: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:50:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:02 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 0x7ff068368c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e436c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f043d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d8c0>, '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 0x1f3a420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3a8b0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1447692795.66995-1538703239', '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:50:02 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:50:02 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:50:02 INFO - Using env: {'DISPLAY': ':0', 09:50:02 INFO - 'HOME': '/home/cltbld', 09:50:02 INFO - 'LANG': 'en_US.UTF-8', 09:50:02 INFO - 'LANGUAGE': 'en_US:en', 09:50:02 INFO - 'LOGNAME': 'cltbld', 09:50:02 INFO - 'MAIL': '/var/mail/cltbld', 09:50:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:02 INFO - 'MOZ_NO_REMOTE': '1', 09:50:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:02 INFO - 'NO_EM_RESTART': '1', 09:50:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:50:02 INFO - 'PWD': '/builds/slave/test-pgo', 09:50:02 INFO - 'SHELL': '/bin/bash', 09:50:02 INFO - 'SHLVL': '1', 09:50:02 INFO - 'TERM': 'linux', 09:50:02 INFO - 'TMOUT': '86400', 09:50:02 INFO - 'USER': 'cltbld', 09:50:02 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1447692795.66995-1538703239', 09:50:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:02 INFO - '_': '/tools/buildbot/bin/python'} 09:50:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:03 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:50:03 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:50:03 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:50:03 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:50:03 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:50:03 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:50:03 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:50:03 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:50:03 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:50:03 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:50:03 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:50:03 INFO - Cleaning up... 09:50:03 INFO - Return code: 0 09:50:03 INFO - Running post-action listener: _resource_record_post_action 09:50:03 INFO - Running post-action listener: _start_resource_monitoring 09:50:03 INFO - Starting resource monitoring. 09:50:03 INFO - ##### 09:50:03 INFO - ##### Running install step. 09:50:03 INFO - ##### 09:50:03 INFO - Running pre-action listener: _resource_record_pre_action 09:50:03 INFO - Running main action method: install 09:50:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:50:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:50:03 INFO - Reading from file tmpfile_stdout 09:50:03 INFO - Detecting whether we're running mozinstall >=1.0... 09:50:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:50:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:50:03 INFO - Reading from file tmpfile_stdout 09:50:03 INFO - Output received: 09:50:03 INFO - Usage: mozinstall [options] installer 09:50:03 INFO - Options: 09:50:03 INFO - -h, --help show this help message and exit 09:50:03 INFO - -d DEST, --destination=DEST 09:50:03 INFO - Directory to install application into. [default: 09:50:03 INFO - "/builds/slave/test-pgo"] 09:50:03 INFO - --app=APP Application being installed. [default: firefox] 09:50:03 INFO - mkdir: /builds/slave/test-pgo/build/application 09:50:03 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:50:03 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:50:17 INFO - Reading from file tmpfile_stdout 09:50:17 INFO - Output received: 09:50:17 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:50:17 INFO - Running post-action listener: _resource_record_post_action 09:50:17 INFO - ##### 09:50:17 INFO - ##### Running run-tests step. 09:50:17 INFO - ##### 09:50:17 INFO - Running pre-action listener: _resource_record_pre_action 09:50:17 INFO - Running main action method: run_tests 09:50:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:50:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:50:17 INFO - Python 2.7.3 09:50:17 INFO - Return code: 0 09:50:17 INFO - grabbing minidump binary from tooltool 09:50: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:50:17 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 0x1f8d8c0>, '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 0x1f3a420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3a8b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:50:17 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:50:17 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:50:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:50:17 INFO - Return code: 0 09:50:17 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:50:17 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:50:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:50:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:50:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:50:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FBWy8FvOTJaUdxdmhI5i3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 09:50:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FBWy8FvOTJaUdxdmhI5i3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost 09:50:17 INFO - Using env: {'DISPLAY': ':0', 09:50:17 INFO - 'HOME': '/home/cltbld', 09:50:17 INFO - 'LANG': 'en_US.UTF-8', 09:50:17 INFO - 'LANGUAGE': 'en_US:en', 09:50:17 INFO - 'LOGNAME': 'cltbld', 09:50:17 INFO - 'MAIL': '/var/mail/cltbld', 09:50:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:50:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:50:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:17 INFO - 'MOZ_NO_REMOTE': '1', 09:50:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:50:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:17 INFO - 'NO_EM_RESTART': '1', 09:50:17 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:50:17 INFO - 'PWD': '/builds/slave/test-pgo', 09:50:17 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:50:17 INFO - 'SHELL': '/bin/bash', 09:50:17 INFO - 'SHLVL': '1', 09:50:17 INFO - 'TERM': 'linux', 09:50:17 INFO - 'TMOUT': '86400', 09:50:17 INFO - 'USER': 'cltbld', 09:50:17 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1447692795.66995-1538703239', 09:50:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:17 INFO - '_': '/tools/buildbot/bin/python'} 09:50:17 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FBWy8FvOTJaUdxdmhI5i3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost'] with output_timeout 3600 09:50:17 INFO - mozversion INFO | application_buildid: 20151116073034 09:50:17 INFO - mozversion INFO | application_changeset: 4294bf91174b71ed7440dc491dac5d15394ec227 09:50:17 INFO - mozversion INFO | application_display_name: Nightly 09:50:17 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:50:17 INFO - mozversion INFO | application_name: Firefox 09:50:17 INFO - mozversion INFO | application_remotingname: firefox 09:50:17 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 09:50:17 INFO - mozversion INFO | application_vendor: Mozilla 09:50:17 INFO - mozversion INFO | application_version: 45.0a1 09:50:17 INFO - mozversion INFO | platform_buildid: 20151116073034 09:50:17 INFO - mozversion INFO | platform_changeset: 4294bf91174b71ed7440dc491dac5d15394ec227 09:50:17 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 09:50:17 INFO - mozversion INFO | platform_version: 45.0a1 09:50:17 INFO - 2015-11-16 09:50:17,966 DEBUG : using testdate: 1447696217 09:50:17 INFO - 2015-11-16 09:50:17,966 DEBUG : actual date: 1447696217 09:50:18 INFO - 2015-11-16 09:50:18,047 INFO : starting webserver on 'localhost:33159' 09:50:18 INFO - 2015-11-16 09:50:18,048 INFO : Starting test suite talos-linux64-ix-037.e 09:50:18 INFO - 2015-11-16 09:50:18,048 INFO : Starting test dromaeo_css 09:50:18 INFO - 2015-11-16 09:50:18,048 DEBUG : operating with platform_type : linux_ 09:50:18 INFO - 2015-11-16 09:50:18,048 INFO : Initialising browser for dromaeo_css test... 09:50:18 INFO - 2015-11-16 09:50:18,055 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHbJ8OG/profile http://localhost:33159/getInfo.html 09:50:24 INFO - 2015-11-16 09:50:24,220 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:50:24 INFO - 2015-11-16 09:50:24,220 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:50:24 INFO - 2015-11-16 09:50:24,220 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:50:24 INFO - 2015-11-16 09:50:24,220 DEBUG : BROWSER_OUTPUT: __metrics 09:50:25 INFO - 2015-11-16 09:50:25,200 INFO : Browser initialized. 09:50:25 INFO - 2015-11-16 09:50:25,200 INFO : Running cycle 1/1 for dromaeo_css test... 09:50:25 INFO - 2015-11-16 09:50:25,201 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHbJ8OG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:50:37 INFO - 2015-11-16 09:50:37,009 DEBUG : BROWSER_OUTPUT: RSS: Main: 141733888 09:50:37 INFO - 2015-11-16 09:50:37,009 DEBUG : BROWSER_OUTPUT: 09:51:26 INFO - 2015-11-16 09:51:26,640 DEBUG : BROWSER_OUTPUT: 1447696286636 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:53:34 INFO - 2015-11-16 09:53:34,584 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33159/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33159/tests/dromaeo/cssquery-ext.html) 09:53:35 INFO - 2015-11-16 09:53:35,608 DEBUG : BROWSER_OUTPUT: RSS: Main: 148103168 09:53:35 INFO - 2015-11-16 09:53:35,608 DEBUG : BROWSER_OUTPUT: 09:56:37 INFO - 2015-11-16 09:56:37,593 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33159/tests/dromaeo/cssquery-ext.html (next: http://localhost:33159/tests/dromaeo/cssquery-jquery.html) 09:56:38 INFO - 2015-11-16 09:56:38,174 DEBUG : BROWSER_OUTPUT: RSS: Main: 140771328 09:56:38 INFO - 2015-11-16 09:56:38,174 DEBUG : BROWSER_OUTPUT: 09:59:39 INFO - 2015-11-16 09:59:39,831 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33159/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33159/tests/dromaeo/cssquery-mootools.html) 09:59:40 INFO - 2015-11-16 09:59:40,417 DEBUG : BROWSER_OUTPUT: RSS: Main: 142241792 09:59:40 INFO - 2015-11-16 09:59:40,418 DEBUG : BROWSER_OUTPUT: 10:02:42 INFO - 2015-11-16 10:02:42,087 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33159/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33159/tests/dromaeo/cssquery-prototype.html) 10:02:42 INFO - 2015-11-16 10:02:42,689 DEBUG : BROWSER_OUTPUT: RSS: Main: 139698176 10:02:42 INFO - 2015-11-16 10:02:42,689 DEBUG : BROWSER_OUTPUT: 10:05:45 INFO - 2015-11-16 10:05:45,066 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33159/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33159/tests/dromaeo/cssquery-yui.html) 10:05:45 INFO - 2015-11-16 10:05:45,659 DEBUG : BROWSER_OUTPUT: RSS: Main: 140595200 10:05:45 INFO - 2015-11-16 10:05:45,660 DEBUG : BROWSER_OUTPUT: 10:08:48 INFO - 2015-11-16 10:08:48,061 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33159/tests/dromaeo/cssquery-yui.html (next: http://localhost:33159/tests/dromaeo/cssquery-dojo.html) 10:08:48 INFO - 2015-11-16 10:08:48,311 DEBUG : BROWSER_OUTPUT: RSS: Main: 144244736 10:08:48 INFO - 2015-11-16 10:08:48,312 DEBUG : BROWSER_OUTPUT: 10:08:48 INFO - 2015-11-16 10:08:48,312 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:08:48 INFO - 2015-11-16 10:08:48,312 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:08:48 INFO - 2015-11-16 10:08:48,312 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:08:48 INFO - 2015-11-16 10:08:48,313 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:08:48 INFO - 2015-11-16 10:08:48,313 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3161.9051428457146;3191.313867518483;3207.326461443097;3232.579764630598;3233.5958005249345;5107.055194788966;5126.794928202872;5193.350831146102;5224.138017227157;5228.4771522847695;5177.094008548508;5193.091209038422;5225.555827754645;5316.388615309241;5327.547158491523;4808.783604737795;4870.634702397317;4917.164082106033;4934.654574179809;4996.1756310208775;4849.442314133867;4922.8523144305545;4948.307236986825;4992.850214493571;5022.472640372763;4758.119747846642;4781;4864.586510146624;4901.730404827733;4917.385326834145;4800.135975524404;4803.543663352011;4817;4831.420229572439;4836.443808961944;4626.9074618507775;4780.235162374003;4794.161021821167;4798.256270278112;4829.661923665345;5055.721935293557;5058.747062646853;5059;5103.974480127613;5139.717315547643;5687.0900655895275;5722.256106706143;5735.139729040636;5747.195392645033;5754.194412782172;5612.186232996233;5677.148427735831;5744.942550574483;5766.884662306772;5788.913166302509;5244.292020577212;5298.496642818926;5308.0710875596615;5321.175217841241;5372.892542149174;5769.68266745333;5789.102689083199;5831.475167234885;5833.416658334133;5842.298924129132;5390.380106287748;5484.643498172686;5490.121580547093;5609.971950140223;5614.9719251403485;5706.71466426677;5716.79991200306;5744;5757.222774925415;5760.683162426023;5705.5435565154685;5714.685692286964;5719;5725.940700970334;5733.0540460823495;5463.235147079412;5567.331920169606;5595.356533998561;5695.857603559944;5713.5714821388565;4394.626456751148;4408.647308215399;4417.028253784162;4423.756693381831;4442.68901176921;3939.684825213976;3954.307996100671;3956.0703234739813;3966.7223294369696;3992.1416895367634;5309.46905309466;5319.654222475527;5396.78412863481;5416.864578385572;5478.753456094485;5627.493525582717;5644.97177514118;5670;5693.231413759089;5709.8287051388525;5325.813596524181;5441.347038355423;5461.344638643309;5482.643628164236;5501.449855014546;4915.508449155127;4938.08645400602;4949.752512374367;4984.675996060245;5032.169692000779;5997.520198384206;6022.879542409128;6031.668258245751;6040.848978775478;6054.122152287893;5553.916691249554;5668.574856885833;5755.165501002248;5756.625819321731;5760.798372056958;5841.50347220474;5929.762809487572;5929.940700592939;5935.436133567304;5974.61165024272;5562.3047119110115;5610.943890561205;5612.607117501899;5621.80323688669;5635.436456354331;5449.809256675997;5568.498835104698;5588.273524441796;5712.885742285214;5729.4843464088435;5314.362276526842;5418.539424148834;5449.482299181572;5502.669839809624;5510.393856675682;5475.260839786578;5502.284702988586;5511.862203444946;5515.117581186991;5525.171224316385;5332.413434522277;5410.59420543453;5410.621256512007;5422.5119739223655;5472.2338872557075;5420.945790542044;5498.3127109111365;5498.532624726943;5502.0371434999515;5508;5459;5468.781248750005;5519.834404967857;5522.530584900168;5523.199136125159 10:08:48 INFO - 2015-11-16 10:08:48,316 DEBUG : BROWSER_OUTPUT: |1;ext.html;592.1768741449387;597.825273337891;608.5679167790868;613.656352442632;646.092240402235;39317;40072.19855602886;40235.1952960941;40241.99395015119;40443.39334909979;40535.391969120414;41225.79387103068;41505;41612;41690;8700.477971321725;8804.735857924272;8813.60338784753;8864.512451815148;8886.4668119913;8560.571971401436;8593.95703021484;8627.568621568927;8673.95663021684;8680.435771674853;8576.69981550646;8597.18326758957;8630.352723545759;8639.265662418702;8694.087120852282;8602.87095693565;8607.39748217625;8634.222919937205;8684;8695.130486951255;8419.915800841974;8487.151284871525;8505.74482765518;8582.656693732244;8627.051024387312;38939.22121557553;39471.40792888109;39482.407763883566;39509.802450987845;39530.20939581192;3042;3103.425866214735;3232.4343239933155;3268.7385009199443;3269.5095735639607;30218.69781302181;30368.088957331314;30503.23741906448;30598.38803223923;30747.538786918216;3377.1725927148004;3389.4915762635555;3391.186115332327;3466.532018177539;3539.2036791721657;271589;272622;274864;275002;275616;42206.577934220266;42761.35857962133;42854.35718464226;57916.42083579195;58205.708971455715;40975.59024409777;40979;40997.180056398705;41117.58882411138;41255;14477.638059048608;14700.338484768212;14720;14724.55826325212;14727.190004549639;11663.066954643607;11764.941175294069;11765.294082355085;11778.469968851423;11804.940975295069;14038.649033774238;14089.506867259597;14118.43526258938;14143.29283535819;14220.786688199685;5819.854503637443;5905.940940590625;5937.80442113151;5938.376470470625;5985.533544281592;878.2490970220497;921.9262459003263;972.3339512434005;1098.8296813993843;1127.8026345389524;27648.308792280353;27965.021224257052;28052.71947280542;28170;28182.43635127286;1009.6112996496402;1014.8832884218261;1053.2785042246087;1103.194667892443;1127.8195488721929;14544.29120574268;14573.92713036428;14577.271136443136;14690.63273418173;14775.26123693811;308804;310910;312824;312984;313689;50083.74958125259;50819.491805082216;50860.23709644358;50942.23586646203;50991.74504127455;1293.6636474516692;1316.8419789625116;1345.8990575706862;1345.9232613908835;1350.1763924006348;25868.741312587386;27007.1897843065;27117.186484405498;27379;31543.684563154075;48636.75681621569;49642.25536617026;49676.75161624169;49684.50315496943;49756.75121624369;288126;289540;290501;290541;290980;40986.38520422136;41940.386557479265;42018;42146.78926605347;42175;42244.577554224066;43914;44037.33943990907;44285.77857110694;44373.77813110914;36910.8154459226;36986;37245.6275437253;37496.62503374931;37698.81150594229;37057.81471092627;37190.25619487649;37360.81319593385;37782;39996.20007599774;35937;36304;36524.63475365212;36541.45187822131;36635.26729465449;32177.517337240428;33332.1666958328;33775.4933676;33788.66211337855;33916.49125263074;25518.617220742075;25633.74366256388;25659.743402565735;25913.352166195997;26194.476110478066 10:08:48 INFO - 2015-11-16 10:08:48,318 DEBUG : BROWSER_OUTPUT: |2;jquery.html;347.4475583821723;347.846947343169;349.3746194312178;350.98947031589046;351.39209168139126;12114.575989840358;12505;16656.333746650118;16869.746953795686;17721.556961075963;11517.251378660401;11567.363794991272;11588.942055289734;11629.185956983014;11701.18091733579;4431.290993441042;4580.221362368388;4585.793639286224;4608.907821843561;4610;4463.085067561142;4567.817287308504;4607.7004994675235;4614.492405835355;4619.422572178478;4557.179707652621;4557.498675145731;4574.748388838612;4653.348531205634;4653.534646535336;4700.4594471635855;4744.264638980963;4752.52474752522;4769.833055843029;4793.137235297645;4145.108801607638;4280.122574872144;4288.399624052635;4290.377895205178;4301.075268817188;13270.668233294246;13298;13491.190528568317;13727;13856.861431385658;1862.4319582527323;1963.9312624058089;1964.7838737738837;2015.0730663894626;2047.3653167518116;9514.28642851789;9856.457894815781;9885.456299903502;9888.802223955552;9935.751606209831;1698.9975914210675;1704.3523461084833;1713.468824664358;1737.6350966297093;1743.2678275124479;62054.37945620577;62075;62704.37295627031;62829;63873.361266387205;7104.609246491389;7108.822279442952;7122.430205583541;7136.143662760398;7159.57042577447;8429.662813487514;8439.409241353169;8450.281726053232;8450.450720703135;8453.154684531497;5714.914276285859;5775.335836378787;5775.797847075416;5802.564807639444;5812.564057695689;5565.552956231409;5628;5648.096304591246;5651.095824668033;5811.157382179645;3244.918877028046;3298.340331933623;3311.569495965509;3314.055494184146;3335.31626016666;1173.6068417080373;1184.5853951117213;1188.8632807227107;1192.9045676345872;1224.222618637154;431.4692927698885;465.9603933665609;467.1591135955335;467.4810959834581;507.713142074734;11259;11430.371329576787;11713.941430292964;11750.118741094451;11964.88035119655;483.43196743825865;491.7123482762552;495.90825697246123;505.6536272653244;509.5363219470264;5528.530074943675;6505.414512693786;6507.511936604679;6573.112629795012;6574.572652777554;545394;554993;558023.0988450561;566738;568295;68329;69990.65004674943;72573.63713181506;75362.24637753662;77535.61232193916;545.1414022913847;553.6705660132214;556.666000399765;556.9192467092249;558.6145559563888;10775.94612026935;10860.945695271474;10907.345559266469;11053.668389948314;11155;34462;36249.81875090607;37257.62742372542;37433;37783.43324850075;44646.55353446424;44750.552494474636;46222.768886155354;47660;51870.481295188074;6623.2383275923885;6736.090627765189;6802;6871.828204294932;6909.7581584644295;12156;12415.503379864704;12419.130660853654;12499.687507812378;12609.810852837398;10216.54025568866;10384.688459346231;10487.161027117965;10845.186611004365;10862.619808306672;10266.43534605574;10587.682369528926;10664.306820056981;10710.571577136827;10889;10473.266871318934;10512;10699.679009629723;10901.781964360827;10904.563817447213;6809.148856392951;6814.591124532544;6942.409895158968;6943.79168624942;6960.095187625576;10685.839712404164;10799.784004319712;10878.564857405616;10955.780884382108;11060.446977650925 10:08:48 INFO - 2015-11-16 10:08:48,319 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1486.026652542585;1755.5962128710396;1799.181372475523;1816.4550634809555;1820.817918208179;7236.421086313096;7421.443391745621;7428.628568571577;7434.1822399536;7607.315341619254;7688.308052275294;7719.266669666386;7720.189380115077;7797.220277972214;7800.609969501516;2265.796078352952;2272.5909336319455;2288.7596802335765;2293.220305096267;2294.8737819420007;2269.841111122222;2297.425643589103;2310.7689231076843;2314.1668999160374;2319.6288593824993;1957.2660252405349;1993.6710442776925;2186.6282731935607;2258.390234636647;2293.036924491709;2171.6742488626674;2178.2485042660255;2181.4873504726374;2182.8690278583335;2183.399565119581;2171.4788450771857;2257.604919139144;2264.5810525052916;2266.195500597281;2271.9889649106153;7521.924780752177;7548.358389536841;7580.924190758077;7601.961990190069;7610.657520411595;4610.147122782296;4642.837500687494;4719.38647975761;4726.432828060655;4731.834385796515;2920.4889144399644;2928.6046383738135;2979.7765167612515;2999.7450216731604;3001.2046807596003;928.3779867488731;936.6721647423416;954.8663187153804;969.1035791892472;981.6515137126289;10274.126699230574;10352.48237588125;10396.844047339297;10411.791764164751;10423.895761042368;4159.708820382604;4196.769177695195;4277.144571085795;4285.421468101828;4293.184294983943;8378.413511054168;8502.319814414832;8513.74458766238;8519.275861551714;8562.357823163287;4661.254199328091;4701.2242979908615;4716.9292460613115;4719.882002949954;4742.07529531738;4283.485981682155;4317.438732964694;4321.503027151855;4346.348047792793;4349.412829268072;3369.124027752802;3451.3960056989927;3459.2043829919257;3462.4460086386057;3481.7562770605814;1047.8009178256107;1058.169337070396;1066.1044722433194;1084.4252546150553;1101.7851518953887;988.1501908358806;1040.7918416316768;1049.1397054415459;1178.9823152652716;1340.919544827294;7038.753643622551;7101;7106.573605583578;7112.288771122846;7140.500164988505;1116.8157254053153;1143.6454699043322;1149.1209224942925;1149.3219000789575;1173.342927960345;5604.6917419541505;5635.5773317001385;5662.773489060474;5698.971505142447;5706.771729130871;8769.517676527852;8885.111488851193;9138.680146194984;9272.350935434455;9277.443353398683;9045.050269721716;9078.86381704275;9086.045965173695;9089.545522723838;9159.267258619295;6996.090508233897;7074.080369552028;7102.715891364391;7113.7154513819905;7132.643367831588;6809.250982392032;6841.726330946706;6862.176538815374;6863.965680171567;6897.517173797786;7798.298153166243;7961.243681850215;8031.879521807061;8113.797155071171;8114.634841432032;8115.75652730419;8286.668533258602;8304.958475207586;8329.333653307842;8354.749357519284;6670.59976401398;6784.05023296729;6863.828404289933;6895.586264824126;6931.133608298963;7347.33873951347;7405.851882962203;7408.6666100026705;7428.925710742823;7430.739924102847;6889.655517224019;6967.686454109476;7021.368076873106;7135.678894449658;7182.784516464514;6693.196816382066;6718.899216511854;6804.897926531007;6839.452843772586;6957.478189135733;6767.323267673193;6975.1978522468535;7055.894161587477;7062;7065.57606543609;6173.660448675366;6257.906131408124;6260.154879091265;6268.498520118471;6292.559520833681;6515.73937042532;6552.934470655233;6557.344265573404;6573.638449885302;6576.638284894377 10:08:48 INFO - 2015-11-16 10:08:48,321 DEBUG : BROWSER_OUTPUT: |4;prototype.html;317.8267844025006;321.7860123018193;322.9564008858805;325.68896703648016;327.91802049487626;6115.633062016283;6208.596441231317;6214.378562143784;6259.780907668232;6322.241331040282;6080.270367555889;6130.2643682758135;6151.938480615193;6174.073888916665;6194.256689197291;4531.818727250906;4683.7892294846815;4688.976555117237;4697.154512187805;4708.128996135726;4694.671373003891;4706.882327941795;4712.5523075307965;4718.245080787075;4722.622190224791;4646.767661616923;4663.48701642819;4663.790129444184;4667.7199368037855;4668.299755036738;4628.652851036169;4640.930386044212;4661.46393164787;4666.53334666534;4675.7895894684825;3965.8413663453425;4063.3295506241434;4088.366303223005;4093.44738460307;4095.7747323897174;5768.913466298009;5835.241418615553;5837.795677151279;5840.065589505659;5875.324337701177;5395.271638328814;5409.323834520685;5411.242426060355;5418.431064738185;5424.240606315119;6463.612183269019;6466.062420948983;6466.094746735461;6492.448141907897;6507.414332710079;4392.802323895432;4486.977565112186;4488.663350248745;4490.910181796378;4498.820047198108;6798.830029249259;6863.553868998499;6880.105586273752;6886.655667216619;6895.275996020446;4581.656375771764;4614.792334344963;4622.168009758276;4641.767911604406;4642.187617166982;4575;4620.584147426748;4642.326862604903;4649.256119020941;4678.134545109166;5381.461853814587;5387.595930305164;5390.51485366319;5391.919121213185;5397.190421436816;6593.7362505500205;6610.7025183866845;6620.073189753439;6623.9006414903815;6660.134182556333;1649.2990479046598;1662.758899959499;1664.0847533856331;1664.3259479910655;1667.4414071286255;1099.2525082943675;1103.5530610102921;1108.9778204435866;1127.1208457403238;1130.8642962844347;6357.554971151975;6471.288158302583;6477.060826180177;6478.870422591522;6515.348465153542;6814.841476948931;6819.659017049128;6832.658367081626;6870.141232345957;6877.140357455318;6468.288488266287;6469.417752402306;6470.741170353227;6511.186101737283;6538.1827271591055;3630.8910732678064;3700.2229531798084;3725.515682961198;3730;3756.1173124315765;7278.672459739324;7301.050863387832;7324.853502930018;7335.1564570075125;7339.559626422431;7033.191183013917;7055.153381594241;7063.364297213173;7075.646217689095;7084.397826184729;7210.495265331377;7237.565746055254;7321.414286857039;7322.0847394075745;7327.45044121693;6849.486288528281;6860.5540639858245;6872.759453419107;6878.793636190922;6884.48366372514;6779.288174741581;6799.082123913407;6806.42145417645;6812.352826481477;6814.284500127415;7069.151701795818;7293.562386256842;7308.342249197598;7327.63361831917;7328.890066649111;4433.623142032834;4456.398386217819;4459.531749166291;4463.062756821104;4466.486354069194;6871.553349032297;6874.553154044971;6876.415504682158;6893.655317234218;6895.724171033103;6477.805665829844;6671.499637527302;6675.632840193836;6681.29846366144;6689.933100668931;6610.933890661032;6664.0670306158145;6672.666366681744;6673.399394054559;6691.899621505584;6463.192100987377;6493.545451818327;6496.285408605144;6515.54391192612;6519.902201467076;6504.284528701934;6510.73957041713;6630.336966303331;6677.599344039373;6681.33186681328;6455.580387274812;6466.579672321284;6494.2856285807575;6497.382748638872;6507.544471886922 10:08:48 INFO - 2015-11-16 10:08:48,321 DEBUG : BROWSER_OUTPUT: |5;yui.html;753.9773806785798;768.665630450754;787.6258777080885;848.716951400732;875.6366108065151;14094.815303627942;14595.92702036491;14598.343074561644;14697.04469209502;14706.264686765673;13545.255010974393;13654.52209172679;13683.726325473484;13687.452501899912;13704;806.5604245686116;807.2049031703767;810.8094597769519;823.6170180865926;824.0729179672868;817;819.3117781063905;820.8932838730957;821.7411515372638;824.3981893217955;848.4909054567272;854.1245223645751;855.2345650642702;857.6697971281039;859.1623167411786;835.9623816928253;836.1638361638362;840.2269911681207;842.1326034184799;846.3652260804397;615.3292910727284;616.5714828194407;617.3579477343558;618.2395653346409;619.2630769384418;13734.107283026671;13785.931070344684;13861.23763193024;13877;13932.651683707887;10165.237607179492;10316.1747060235;10343.844842327371;10505.4222017789;10610.151187904949;9718.854217186748;9871.950640246752;10106.242031847642;10250.897491025144;10646.57413703451;3205.1537358610813;3273.4435146025235;3274.197821533716;3282.917927051819;3373.122988023107;46084.53915460836;46276.53723462756;47377;47633.28550071752;47697.28454073192;7456.589887556128;7506.3244308012545;7556.735514257085;7670.309672129423;7749.147593764681;11159.274647148071;11278.210525263154;11296.378699171624;11301.943490282496;11321.264117832314;6524.347565243438;6575.638339891256;6625.469962402996;6727.327267273234;6830.59016459014;4478.529754375743;4502.797374118172;4524.343970124313;4534.841280555164;4605.032943081923;2730.945381092407;2741.931451713723;2758.5724212747054;2766.806323557332;2767.501849667079;414.9024979129902;417.7827529684547;420.56471551943594;421.44158989339246;429.10745649050523;605.4006533531859;623.3890787028737;635.3265538529174;668.8929771236578;674.9055132281485;8564.3148548116;8798.164174403422;9091.27269818413;9279.582418791171;9289.34974551775;576.2105914896619;583.2796496327032;647.6373230990566;655.4101308822003;706.9469789765789;4023.155137421116;4092.5498195199098;4358.389825424443;4395.384646149541;4401.6698747594055;57852.71073644689;57936;57986.420135798944;58184.41815581875;58541.41458585445;53013.204801928005;53436.46563534315;53505.464945350825;53736.193957090676;53927.730361347945;45116.3232551512;47184.7640761794;47343.52656473391;47606.04787904223;47894.76052619715;8220.876686849822;8376.49741015541;8489.10864359258;8562.657493700182;8584.141585841615;33744.49383259204;33944.66055339415;34122.317553649285;34205.48691769576;34377.48433773445;41367.58632413638;41887;45153.774231128635;46026.53973460222;46195;7105.111861017373;7370.77887663371;7388.224236455095;7399.334059934632;7501.512401693873;11602;11764.647060588197;11883.227590206609;11975.101867360157;12136;10361.948190259;10398.68803935883;10427.165826733995;10498.842517362398;10600.522976466233;10630.574777009142;10783.946080269863;10950.178736594627;10979.670609881716;11274.154438416988;9956.20350371983;10059.497025148567;10647.094996925038;10836.67489975302;10849.620263290746;8971.730848074569;9096.77258068527;9154.725358239264;9379.765505862408;9469.810603788024;9056.1687198421;9382.437053776795;9748.9025109748;9798.85301720489;9985.60057597688 10:08:48 INFO - 2015-11-16 10:08:48,321 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:08:48 INFO - 2015-11-16 10:08:48,321 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:08:48 INFO - 2015-11-16 10:08:48,321 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,290 10:08:48 INFO - 2015-11-16 10:08:48,321 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:08:48 INFO - 2015-11-16 10:08:48,321 DEBUG : BROWSER_OUTPUT: __startTimestamp1447697328310__endTimestamp 10:08:48 INFO - 2015-11-16 10:08:48,321 DEBUG : BROWSER_OUTPUT: 10:08:48 INFO - 2015-11-16 10:08:48,323 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:08:48 INFO - 2015-11-16 10:08:48,323 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:08:48 INFO - 2015-11-16 10:08:48,323 DEBUG : BROWSER_OUTPUT: 10:08:48 INFO - 2015-11-16 10:08:48,323 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5278.54 Median:5461.34 stddev:577.17 (10.6%) stddev-sans-first:554.54 10:08:48 INFO - 2015-11-16 10:08:48,323 DEBUG : BROWSER_OUTPUT: Values: 3161.9 3191.3 3207.3 3232.6 3233.6 5107.1 5126.8 5193.4 5224.1 5228.5 5177.1 5193.1 5225.6 5316.4 5327.5 4808.8 4870.6 4917.2 4934.7 4996.2 4849.4 4922.9 4948.3 4992.9 5022.5 4758.1 4781.0 4864.6 4901.7 4917.4 4800.1 4803.5 4817.0 4831.4 4836.4 4626.9 4780.2 4794.2 4798.3 4829.7 5055.7 5058.7 5059.0 5104.0 5139.7 5687.1 5722.3 5735.1 5747.2 5754.2 5612.2 5677.1 5744.9 5766.9 5788.9 5244.3 5298.5 5308.1 5321.2 5372.9 5769.7 5789.1 5831.5 5833.4 5842.3 5390.4 5484.6 5490.1 5610.0 5615.0 5706.7 5716.8 5744.0 5757.2 5760.7 5705.5 5714.7 5719.0 5725.9 5733.1 5463.2 5567.3 5595.4 5695.9 5713.6 4394.6 4408.6 4417.0 4423.8 4442.7 3939.7 3954.3 3956.1 3966.7 3992.1 5309.5 5319.7 5396.8 5416.9 5478.8 5627.5 5645.0 5670.0 5693.2 5709.8 5325.8 5441.3 5461.3 5482.6 5501.4 4915.5 4938.1 4949.8 4984.7 5032.2 5997.5 6022.9 6031.7 6040.8 6054.1 5553.9 5668.6 5755.2 5756.6 5760.8 5841.5 5929.8 5929.9 5935.4 5974.6 5562.3 5610.9 5612.6 5621.8 5635.4 5449.8 5568.5 5588.3 5712.9 5729.5 5314.4 5418.5 5449.5 5502.7 5510.4 5475.3 5502.3 5511.9 5515.1 5525.2 5332.4 5410.6 5410.6 5422.5 5472.2 5420.9 5498.3 5498.5 5502.0 5508.0 5459.0 5468.8 5519.8 5522.5 5523.2 10:08:48 INFO - 2015-11-16 10:08:48,323 DEBUG : BROWSER_OUTPUT: 10:08:48 INFO - 2015-11-16 10:08:48,323 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45670.06 Median:37217.94 stddev:76328.36 (205.1%) stddev-sans-first:76467.44 10:08:48 INFO - 2015-11-16 10:08:48,323 DEBUG : BROWSER_OUTPUT: Values: 592.2 597.8 608.6 613.7 646.1 39317.0 40072.2 40235.2 40242.0 40443.4 40535.4 41225.8 41505.0 41612.0 41690.0 8700.5 8804.7 8813.6 8864.5 8886.5 8560.6 8594.0 8627.6 8674.0 8680.4 8576.7 8597.2 8630.4 8639.3 8694.1 8602.9 8607.4 8634.2 8684.0 8695.1 8419.9 8487.2 8505.7 8582.7 8627.1 38939.2 39471.4 39482.4 39509.8 39530.2 3042.0 3103.4 3232.4 3268.7 3269.5 30218.7 30368.1 30503.2 30598.4 30747.5 3377.2 3389.5 3391.2 3466.5 3539.2 271589.0 272622.0 274864.0 275002.0 275616.0 42206.6 42761.4 42854.4 57916.4 58205.7 40975.6 40979.0 40997.2 41117.6 41255.0 14477.6 14700.3 14720.0 14724.6 14727.2 11663.1 11764.9 11765.3 11778.5 11804.9 14038.6 14089.5 14118.4 14143.3 14220.8 5819.9 5905.9 5937.8 5938.4 5985.5 878.2 921.9 972.3 1098.8 1127.8 27648.3 27965.0 28052.7 28170.0 28182.4 1009.6 1014.9 1053.3 1103.2 1127.8 14544.3 14573.9 14577.3 14690.6 14775.3 308804.0 310910.0 312824.0 312984.0 313689.0 50083.7 50819.5 50860.2 50942.2 50991.7 1293.7 1316.8 1345.9 1345.9 1350.2 25868.7 27007.2 27117.2 27379.0 31543.7 48636.8 49642.3 49676.8 49684.5 49756.8 288126.0 289540.0 290501.0 290541.0 290980.0 40986.4 41940.4 42018.0 42146.8 42175.0 42244.6 43914.0 44037.3 44285.8 44373.8 36910.8 36986.0 37245.6 37496.6 37698.8 37057.8 37190.3 37360.8 37782.0 39996.2 35937.0 36304.0 36524.6 36541.5 36635.3 32177.5 33332.2 33775.5 33788.7 33916.5 25518.6 25633.7 25659.7 25913.4 26194.5 10:08:48 INFO - 2015-11-16 10:08:48,323 DEBUG : BROWSER_OUTPUT: 10:08:48 INFO - 2015-11-16 10:08:48,324 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27375.64 Median:4557.34 stddev:91539.49 (2008.6%) stddev-sans-first:91773.79 10:08:48 INFO - 2015-11-16 10:08:48,325 DEBUG : BROWSER_OUTPUT: Values: 347.4 347.8 349.4 351.0 351.4 12114.6 12505.0 16656.3 16869.7 17721.6 11517.3 11567.4 11588.9 11629.2 11701.2 4431.3 4580.2 4585.8 4608.9 4610.0 4463.1 4567.8 4607.7 4614.5 4619.4 4557.2 4557.5 4574.7 4653.3 4653.5 4700.5 4744.3 4752.5 4769.8 4793.1 4145.1 4280.1 4288.4 4290.4 4301.1 13270.7 13298.0 13491.2 13727.0 13856.9 1862.4 1963.9 1964.8 2015.1 2047.4 9514.3 9856.5 9885.5 9888.8 9935.8 1699.0 1704.4 1713.5 1737.6 1743.3 62054.4 62075.0 62704.4 62829.0 63873.4 7104.6 7108.8 7122.4 7136.1 7159.6 8429.7 8439.4 8450.3 8450.5 8453.2 5714.9 5775.3 5775.8 5802.6 5812.6 5565.6 5628.0 5648.1 5651.1 5811.2 3244.9 3298.3 3311.6 3314.1 3335.3 1173.6 1184.6 1188.9 1192.9 1224.2 431.5 466.0 467.2 467.5 507.7 11259.0 11430.4 11713.9 11750.1 11964.9 483.4 491.7 495.9 505.7 509.5 5528.5 6505.4 6507.5 6573.1 6574.6 545394.0 554993.0 558023.1 566738.0 568295.0 68329.0 69990.7 72573.6 75362.2 77535.6 545.1 553.7 556.7 556.9 558.6 10775.9 10860.9 10907.3 11053.7 11155.0 34462.0 36249.8 37257.6 37433.0 37783.4 44646.6 44750.6 46222.8 47660.0 51870.5 6623.2 6736.1 6802.0 6871.8 6909.8 12156.0 12415.5 12419.1 12499.7 12609.8 10216.5 10384.7 10487.2 10845.2 10862.6 10266.4 10587.7 10664.3 10710.6 10889.0 10473.3 10512.0 10699.7 10901.8 10904.6 6809.1 6814.6 6942.4 6943.8 6960.1 10685.8 10799.8 10878.6 10955.8 11060.4 10:08:48 INFO - 2015-11-16 10:08:48,325 DEBUG : BROWSER_OUTPUT: 10:08:48 INFO - 2015-11-16 10:08:48,325 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5338.00 Median:6555.14 stddev:2725.23 (41.6%) stddev-sans-first:2717.50 10:08:48 INFO - 2015-11-16 10:08:48,325 DEBUG : BROWSER_OUTPUT: Values: 1486.0 1755.6 1799.2 1816.5 1820.8 7236.4 7421.4 7428.6 7434.2 7607.3 7688.3 7719.3 7720.2 7797.2 7800.6 2265.8 2272.6 2288.8 2293.2 2294.9 2269.8 2297.4 2310.8 2314.2 2319.6 1957.3 1993.7 2186.6 2258.4 2293.0 2171.7 2178.2 2181.5 2182.9 2183.4 2171.5 2257.6 2264.6 2266.2 2272.0 7521.9 7548.4 7580.9 7602.0 7610.7 4610.1 4642.8 4719.4 4726.4 4731.8 2920.5 2928.6 2979.8 2999.7 3001.2 928.4 936.7 954.9 969.1 981.7 10274.1 10352.5 10396.8 10411.8 10423.9 4159.7 4196.8 4277.1 4285.4 4293.2 8378.4 8502.3 8513.7 8519.3 8562.4 4661.3 4701.2 4716.9 4719.9 4742.1 4283.5 4317.4 4321.5 4346.3 4349.4 3369.1 3451.4 3459.2 3462.4 3481.8 1047.8 1058.2 1066.1 1084.4 1101.8 988.2 1040.8 1049.1 1179.0 1340.9 7038.8 7101.0 7106.6 7112.3 7140.5 1116.8 1143.6 1149.1 1149.3 1173.3 5604.7 5635.6 5662.8 5699.0 5706.8 8769.5 8885.1 9138.7 9272.4 9277.4 9045.1 9078.9 9086.0 9089.5 9159.3 6996.1 7074.1 7102.7 7113.7 7132.6 6809.3 6841.7 6862.2 6864.0 6897.5 7798.3 7961.2 8031.9 8113.8 8114.6 8115.8 8286.7 8305.0 8329.3 8354.7 6670.6 6784.1 6863.8 6895.6 6931.1 7347.3 7405.9 7408.7 7428.9 7430.7 6889.7 6967.7 7021.4 7135.7 7182.8 6693.2 6718.9 6804.9 6839.5 6957.5 6767.3 6975.2 7055.9 7062.0 7065.6 6173.7 6257.9 6260.2 6268.5 6292.6 6515.7 6552.9 6557.3 6573.6 6576.6 10:08:48 INFO - 2015-11-16 10:08:48,326 DEBUG : BROWSER_OUTPUT: 10:08:48 INFO - 2015-11-16 10:08:48,326 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5524.13 Median:6406.57 stddev:1710.15 (26.7%) stddev-sans-first:1669.70 10:08:48 INFO - 2015-11-16 10:08:48,327 DEBUG : BROWSER_OUTPUT: Values: 317.8 321.8 323.0 325.7 327.9 6115.6 6208.6 6214.4 6259.8 6322.2 6080.3 6130.3 6151.9 6174.1 6194.3 4531.8 4683.8 4689.0 4697.2 4708.1 4694.7 4706.9 4712.6 4718.2 4722.6 4646.8 4663.5 4663.8 4667.7 4668.3 4628.7 4640.9 4661.5 4666.5 4675.8 3965.8 4063.3 4088.4 4093.4 4095.8 5768.9 5835.2 5837.8 5840.1 5875.3 5395.3 5409.3 5411.2 5418.4 5424.2 6463.6 6466.1 6466.1 6492.4 6507.4 4392.8 4487.0 4488.7 4490.9 4498.8 6798.8 6863.6 6880.1 6886.7 6895.3 4581.7 4614.8 4622.2 4641.8 4642.2 4575.0 4620.6 4642.3 4649.3 4678.1 5381.5 5387.6 5390.5 5391.9 5397.2 6593.7 6610.7 6620.1 6623.9 6660.1 1649.3 1662.8 1664.1 1664.3 1667.4 1099.3 1103.6 1109.0 1127.1 1130.9 6357.6 6471.3 6477.1 6478.9 6515.3 6814.8 6819.7 6832.7 6870.1 6877.1 6468.3 6469.4 6470.7 6511.2 6538.2 3630.9 3700.2 3725.5 3730.0 3756.1 7278.7 7301.1 7324.9 7335.2 7339.6 7033.2 7055.2 7063.4 7075.6 7084.4 7210.5 7237.6 7321.4 7322.1 7327.5 6849.5 6860.6 6872.8 6878.8 6884.5 6779.3 6799.1 6806.4 6812.4 6814.3 7069.2 7293.6 7308.3 7327.6 7328.9 4433.6 4456.4 4459.5 4463.1 4466.5 6871.6 6874.6 6876.4 6893.7 6895.7 6477.8 6671.5 6675.6 6681.3 6689.9 6610.9 6664.1 6672.7 6673.4 6691.9 6463.2 6493.5 6496.3 6515.5 6519.9 6504.3 6510.7 6630.3 6677.6 6681.3 6455.6 6466.6 6494.3 6497.4 6507.5 10:08:48 INFO - 2015-11-16 10:08:48,327 DEBUG : BROWSER_OUTPUT: 10:08:48 INFO - 2015-11-16 10:08:48,327 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13348.10 Median:47796.02 stddev:16131.86 (33.8%) stddev-sans-first:16149.39 10:08:48 INFO - 2015-11-16 10:08:48,327 DEBUG : BROWSER_OUTPUT: Values: 754.0 768.7 787.6 848.7 875.6 14094.8 14595.9 14598.3 14697.0 14706.3 13545.3 13654.5 13683.7 13687.5 13704.0 806.6 807.2 810.8 823.6 824.1 817.0 819.3 820.9 821.7 824.4 848.5 854.1 855.2 857.7 859.2 836.0 836.2 840.2 842.1 846.4 615.3 616.6 617.4 618.2 619.3 13734.1 13785.9 13861.2 13877.0 13932.7 10165.2 10316.2 10343.8 10505.4 10610.2 9718.9 9872.0 10106.2 10250.9 10646.6 3205.2 3273.4 3274.2 3282.9 3373.1 46084.5 46276.5 47377.0 47633.3 47697.3 7456.6 7506.3 7556.7 7670.3 7749.1 11159.3 11278.2 11296.4 11301.9 11321.3 6524.3 6575.6 6625.5 6727.3 6830.6 4478.5 4502.8 4524.3 4534.8 4605.0 2730.9 2741.9 2758.6 2766.8 2767.5 414.9 417.8 420.6 421.4 429.1 605.4 623.4 635.3 668.9 674.9 8564.3 8798.2 9091.3 9279.6 9289.3 576.2 583.3 647.6 655.4 706.9 4023.2 4092.5 4358.4 4395.4 4401.7 57852.7 57936.0 57986.4 58184.4 58541.4 53013.2 53436.5 53505.5 53736.2 53927.7 45116.3 47184.8 47343.5 47606.0 47894.8 8220.9 8376.5 8489.1 8562.7 8584.1 33744.5 33944.7 34122.3 34205.5 34377.5 41367.6 41887.0 45153.8 46026.5 46195.0 7105.1 7370.8 7388.2 7399.3 7501.5 11602.0 11764.6 11883.2 11975.1 12136.0 10361.9 10398.7 10427.2 10498.8 10600.5 10630.6 10783.9 10950.2 10979.7 11274.2 9956.2 10059.5 10647.1 10836.7 10849.6 8971.7 9096.8 9154.7 9379.8 9469.8 9056.2 9382.4 9748.9 9798.9 9985.6 10:08:48 INFO - 2015-11-16 10:08:48,327 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:08:48 INFO - 2015-11-16 10:08:48,327 DEBUG : BROWSER_OUTPUT: 10:08:48 INFO - 2015-11-16 10:08:48,908 INFO : Browser exited with error code: 0 10:08:48 INFO - 2015-11-16 10:08:48,927 INFO : Completed test dromaeo_css (00:18:30) 10:08:48 INFO - 2015-11-16 10:08:48,927 INFO : Starting test kraken 10:08:48 INFO - 2015-11-16 10:08:48,927 DEBUG : operating with platform_type : linux_ 10:08:48 INFO - 2015-11-16 10:08:48,927 INFO : Initialising browser for kraken test... 10:08:48 INFO - 2015-11-16 10:08:48,933 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUoeAQ6/profile http://localhost:33159/getInfo.html 10:08:53 INFO - 2015-11-16 10:08:53,432 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:08:53 INFO - 2015-11-16 10:08:53,432 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:08:53 INFO - 2015-11-16 10:08:53,432 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:08:53 INFO - 2015-11-16 10:08:53,432 DEBUG : BROWSER_OUTPUT: __metrics 10:08:54 INFO - 2015-11-16 10:08:54,484 INFO : Browser initialized. 10:08:54 INFO - 2015-11-16 10:08:54,484 INFO : Running cycle 1/1 for kraken test... 10:08:54 INFO - 2015-11-16 10:08:54,485 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUoeAQ6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:09:06 INFO - 2015-11-16 10:09:06,278 DEBUG : BROWSER_OUTPUT: RSS: Main: 141684736 10:09:06 INFO - 2015-11-16 10:09:06,279 DEBUG : BROWSER_OUTPUT: 10:09:08 INFO - 2015-11-16 10:09:08,774 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33159/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33159/tests/kraken/driver.html?testName=audio-beat-detection) 10:09:09 INFO - 2015-11-16 10:09:09,376 DEBUG : BROWSER_OUTPUT: RSS: Main: 141574144 10:09:09 INFO - 2015-11-16 10:09:09,376 DEBUG : BROWSER_OUTPUT: 10:09:12 INFO - 2015-11-16 10:09:12,019 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33159/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33159/tests/kraken/driver.html?testName=audio-dft) 10:09:12 INFO - 2015-11-16 10:09:12,608 DEBUG : BROWSER_OUTPUT: RSS: Main: 142397440 10:09:12 INFO - 2015-11-16 10:09:12,608 DEBUG : BROWSER_OUTPUT: 10:09:15 INFO - 2015-11-16 10:09:15,466 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33159/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33159/tests/kraken/driver.html?testName=audio-fft) 10:09:16 INFO - 2015-11-16 10:09:16,048 DEBUG : BROWSER_OUTPUT: RSS: Main: 137203712 10:09:16 INFO - 2015-11-16 10:09:16,048 DEBUG : BROWSER_OUTPUT: 10:09:18 INFO - 2015-11-16 10:09:18,008 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33159/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33159/tests/kraken/driver.html?testName=audio-oscillator) 10:09:18 INFO - 2015-11-16 10:09:18,591 DEBUG : BROWSER_OUTPUT: RSS: Main: 136683520 10:09:18 INFO - 2015-11-16 10:09:18,591 DEBUG : BROWSER_OUTPUT: 10:09:20 INFO - 2015-11-16 10:09:20,769 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33159/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33159/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:09:21 INFO - 2015-11-16 10:09:21,351 DEBUG : BROWSER_OUTPUT: RSS: Main: 137342976 10:09:21 INFO - 2015-11-16 10:09:21,351 DEBUG : BROWSER_OUTPUT: 10:09:24 INFO - 2015-11-16 10:09:24,340 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33159/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33159/tests/kraken/driver.html?testName=imaging-darkroom) 10:09:24 INFO - 2015-11-16 10:09:24,926 DEBUG : BROWSER_OUTPUT: RSS: Main: 138465280 10:09:24 INFO - 2015-11-16 10:09:24,926 DEBUG : BROWSER_OUTPUT: 10:09:28 INFO - 2015-11-16 10:09:28,295 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33159/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33159/tests/kraken/driver.html?testName=imaging-desaturate) 10:09:28 INFO - 2015-11-16 10:09:28,880 DEBUG : BROWSER_OUTPUT: RSS: Main: 139706368 10:09:28 INFO - 2015-11-16 10:09:28,880 DEBUG : BROWSER_OUTPUT: 10:09:31 INFO - 2015-11-16 10:09:31,742 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33159/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33159/tests/kraken/driver.html?testName=json-parse-financial) 10:09:32 INFO - 2015-11-16 10:09:32,323 DEBUG : BROWSER_OUTPUT: RSS: Main: 139841536 10:09:32 INFO - 2015-11-16 10:09:32,323 DEBUG : BROWSER_OUTPUT: 10:09:33 INFO - 2015-11-16 10:09:33,932 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33159/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33159/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:09:34 INFO - 2015-11-16 10:09:34,498 DEBUG : BROWSER_OUTPUT: RSS: Main: 138489856 10:09:34 INFO - 2015-11-16 10:09:34,498 DEBUG : BROWSER_OUTPUT: 10:09:36 INFO - 2015-11-16 10:09:36,369 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33159/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33159/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:09:36 INFO - 2015-11-16 10:09:36,981 DEBUG : BROWSER_OUTPUT: RSS: Main: 139526144 10:09:36 INFO - 2015-11-16 10:09:36,982 DEBUG : BROWSER_OUTPUT: 10:09:39 INFO - 2015-11-16 10:09:39,062 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33159/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33159/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:09:39 INFO - 2015-11-16 10:09:39,655 DEBUG : BROWSER_OUTPUT: RSS: Main: 139091968 10:09:39 INFO - 2015-11-16 10:09:39,655 DEBUG : BROWSER_OUTPUT: 10:09:42 INFO - 2015-11-16 10:09:42,094 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33159/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33159/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:09:42 INFO - 2015-11-16 10:09:42,687 DEBUG : BROWSER_OUTPUT: RSS: Main: 139235328 10:09:42 INFO - 2015-11-16 10:09:42,687 DEBUG : BROWSER_OUTPUT: 10:09:45 INFO - 2015-11-16 10:09:45,267 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33159/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33159/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:09:45 INFO - 2015-11-16 10:09:45,854 DEBUG : BROWSER_OUTPUT: RSS: Main: 139091968 10:09:45 INFO - 2015-11-16 10:09:45,854 DEBUG : BROWSER_OUTPUT: 10:09:47 INFO - 2015-11-16 10:09:47,507 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33159/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33159/tests/kraken/driver.html?testName=ai-astar) 10:09:47 INFO - 2015-11-16 10:09:47,757 DEBUG : BROWSER_OUTPUT: RSS: Main: 140070912 10:09:47 INFO - 2015-11-16 10:09:47,757 DEBUG : BROWSER_OUTPUT: 10:09:47 INFO - 2015-11-16 10:09:47,758 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:09:47 INFO - 2015-11-16 10:09:47,758 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:09:47 INFO - 2015-11-16 10:09:47,758 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:09:47 INFO - 2015-11-16 10:09:47,758 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:09:47 INFO - 2015-11-16 10:09:47,758 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;105;112;110;111;123;109;112;112;110 10:09:47 INFO - 2015-11-16 10:09:47,758 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;128;149;164;139;153;149;128;159;127 10:09:47 INFO - 2015-11-16 10:09:47,759 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;161;163;161;162;162;165;169;162 10:09:47 INFO - 2015-11-16 10:09:47,759 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;73;72;74;138;72;72;71;71 10:09:47 INFO - 2015-11-16 10:09:47,759 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;90;136;89;90;91;129;89;94;131 10:09:47 INFO - 2015-11-16 10:09:47,759 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;109;109;110;110;109;111;110 10:09:47 INFO - 2015-11-16 10:09:47,759 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;146;146;147;147;146;147;147;146 10:09:47 INFO - 2015-11-16 10:09:47,759 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;97;96;96;96;96;96 10:09:47 INFO - 2015-11-16 10:09:47,759 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;65;62;61;63;66;62;61;60;59 10:09:47 INFO - 2015-11-16 10:09:47,760 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;69;69;69;69;69;70;69 10:09:47 INFO - 2015-11-16 10:09:47,760 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;83;92;85;83;84;83;85;85;88 10:09:47 INFO - 2015-11-16 10:09:47,760 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;132;118;116;121;125;117;119;117;120;126 10:09:47 INFO - 2015-11-16 10:09:47,760 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;154;149;159;151;139;156;154;143;139 10:09:47 INFO - 2015-11-16 10:09:47,760 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;67;66;68;65;67;68;67;66;67 10:09:47 INFO - 2015-11-16 10:09:47,760 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:09:47 INFO - 2015-11-16 10:09:47,760 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:09:47 INFO - 2015-11-16 10:09:47,761 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,704 10:09:47 INFO - 2015-11-16 10:09:47,761 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:09:47 INFO - 2015-11-16 10:09:47,761 DEBUG : BROWSER_OUTPUT: __startTimestamp1447697387756__endTimestamp 10:09:47 INFO - 2015-11-16 10:09:47,761 DEBUG : BROWSER_OUTPUT: 10:09:47 INFO - 2015-11-16 10:09:47,764 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:09:47 INFO - 2015-11-16 10:09:47,765 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:09:47 INFO - 2015-11-16 10:09:47,765 DEBUG : BROWSER_OUTPUT: 10:09:47 INFO - 2015-11-16 10:09:47,765 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.70 Median:112.00 stddev:4.57 (4.1%) stddev-sans-first:4.82 10:09:47 INFO - 2015-11-16 10:09:47,765 DEBUG : BROWSER_OUTPUT: Values: 113.0 105.0 112.0 110.0 111.0 123.0 109.0 112.0 112.0 110.0 10:09:47 INFO - 2015-11-16 10:09:47,766 DEBUG : BROWSER_OUTPUT: 10:09:47 INFO - 2015-11-16 10:09:47,766 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.60 Median:149.50 stddev:13.39 (9.0%) stddev-sans-first:14.06 10:09:47 INFO - 2015-11-16 10:09:47,766 DEBUG : BROWSER_OUTPUT: Values: 150.0 128.0 149.0 164.0 139.0 153.0 149.0 128.0 159.0 127.0 10:09:47 INFO - 2015-11-16 10:09:47,766 DEBUG : BROWSER_OUTPUT: 10:09:47 INFO - 2015-11-16 10:09:47,766 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.80 Median:162.00 stddev:2.49 (1.5%) stddev-sans-first:2.62 10:09:47 INFO - 2015-11-16 10:09:47,767 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 161.0 163.0 161.0 162.0 162.0 165.0 169.0 162.0 10:09:47 INFO - 2015-11-16 10:09:47,767 DEBUG : BROWSER_OUTPUT: 10:09:47 INFO - 2015-11-16 10:09:47,767 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.80 Median:72.00 stddev:20.82 (28.9%) stddev-sans-first:21.98 10:09:47 INFO - 2015-11-16 10:09:47,767 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 73.0 72.0 74.0 138.0 72.0 72.0 71.0 71.0 10:09:47 INFO - 2015-11-16 10:09:47,768 DEBUG : BROWSER_OUTPUT: 10:09:47 INFO - 2015-11-16 10:09:47,768 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.80 Median:89.50 stddev:20.27 (22.7%) stddev-sans-first:20.88 10:09:47 INFO - 2015-11-16 10:09:47,768 DEBUG : BROWSER_OUTPUT: Values: 89.0 90.0 136.0 89.0 90.0 91.0 129.0 89.0 94.0 131.0 10:09:47 INFO - 2015-11-16 10:09:47,768 DEBUG : BROWSER_OUTPUT: 10:09:47 INFO - 2015-11-16 10:09:47,768 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 10:09:47 INFO - 2015-11-16 10:09:47,768 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 109.0 109.0 110.0 110.0 109.0 111.0 110.0 10:09:47 INFO - 2015-11-16 10:09:47,768 DEBUG : BROWSER_OUTPUT: 10:09:47 INFO - 2015-11-16 10:09:47,768 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 10:09:47 INFO - 2015-11-16 10:09:47,768 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 146.0 146.0 147.0 147.0 146.0 147.0 147.0 146.0 10:09:47 INFO - 2015-11-16 10:09:47,769 DEBUG : BROWSER_OUTPUT: 10:09:47 INFO - 2015-11-16 10:09:47,769 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:09:47 INFO - 2015-11-16 10:09:47,769 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 10:09:47 INFO - 2015-11-16 10:09:47,769 DEBUG : BROWSER_OUTPUT: 10:09:47 INFO - 2015-11-16 10:09:47,769 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.00 Median:62.00 stddev:2.16 (3.5%) stddev-sans-first:2.26 10:09:47 INFO - 2015-11-16 10:09:47,769 DEBUG : BROWSER_OUTPUT: Values: 61.0 65.0 62.0 61.0 63.0 66.0 62.0 61.0 60.0 59.0 10:09:47 INFO - 2015-11-16 10:09:47,769 DEBUG : BROWSER_OUTPUT: 10:09:47 INFO - 2015-11-16 10:09:47,769 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 10:09:47 INFO - 2015-11-16 10:09:47,770 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 69.0 69.0 69.0 69.0 69.0 70.0 69.0 10:09:47 INFO - 2015-11-16 10:09:47,770 DEBUG : BROWSER_OUTPUT: 10:09:47 INFO - 2015-11-16 10:09:47,770 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.00 stddev:2.88 (3.4%) stddev-sans-first:2.96 10:09:47 INFO - 2015-11-16 10:09:47,770 DEBUG : BROWSER_OUTPUT: Values: 83.0 83.0 92.0 85.0 83.0 84.0 83.0 85.0 85.0 88.0 10:09:47 INFO - 2015-11-16 10:09:47,770 DEBUG : BROWSER_OUTPUT: 10:09:47 INFO - 2015-11-16 10:09:47,770 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.10 Median:120.50 stddev:5.09 (4.2%) stddev-sans-first:3.55 10:09:47 INFO - 2015-11-16 10:09:47,770 DEBUG : BROWSER_OUTPUT: Values: 132.0 118.0 116.0 121.0 125.0 117.0 119.0 117.0 120.0 126.0 10:09:47 INFO - 2015-11-16 10:09:47,770 DEBUG : BROWSER_OUTPUT: 10:09:47 INFO - 2015-11-16 10:09:47,770 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.50 Median:152.50 stddev:7.46 (4.9%) stddev-sans-first:7.40 10:09:47 INFO - 2015-11-16 10:09:47,770 DEBUG : BROWSER_OUTPUT: Values: 141.0 154.0 149.0 159.0 151.0 139.0 156.0 154.0 143.0 139.0 10:09:47 INFO - 2015-11-16 10:09:47,771 DEBUG : BROWSER_OUTPUT: 10:09:47 INFO - 2015-11-16 10:09:47,771 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.99 (1.5%) stddev-sans-first:0.97 10:09:47 INFO - 2015-11-16 10:09:47,772 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 66.0 68.0 65.0 67.0 68.0 67.0 66.0 67.0 10:09:47 INFO - 2015-11-16 10:09:47,772 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:09:47 INFO - 2015-11-16 10:09:47,772 DEBUG : BROWSER_OUTPUT: 10:09:48 INFO - 2015-11-16 10:09:48,648 INFO : Browser exited with error code: 0 10:09:48 INFO - 2015-11-16 10:09:48,696 INFO : Completed test kraken (00:00:59) 10:09:48 INFO - 2015-11-16 10:09:48,696 INFO : Starting test v8_7 10:09:48 INFO - 2015-11-16 10:09:48,696 DEBUG : operating with platform_type : linux_ 10:09:48 INFO - 2015-11-16 10:09:48,697 INFO : Initialising browser for v8_7 test... 10:09:48 INFO - 2015-11-16 10:09:48,703 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphu3m5t/profile http://localhost:33159/getInfo.html 10:09:53 INFO - 2015-11-16 10:09:53,383 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:09:53 INFO - 2015-11-16 10:09:53,383 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:09:53 INFO - 2015-11-16 10:09:53,384 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:09:53 INFO - 2015-11-16 10:09:53,384 DEBUG : BROWSER_OUTPUT: __metrics 10:09:54 INFO - 2015-11-16 10:09:54,408 INFO : Browser initialized. 10:09:54 INFO - 2015-11-16 10:09:54,408 INFO : Running cycle 1/1 for v8_7 test... 10:09:54 INFO - 2015-11-16 10:09:54,409 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphu3m5t/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:10:06 INFO - 2015-11-16 10:10:06,200 DEBUG : BROWSER_OUTPUT: RSS: Main: 141205504 10:10:06 INFO - 2015-11-16 10:10:06,200 DEBUG : BROWSER_OUTPUT: 10:10:27 INFO - 2015-11-16 10:10:27,590 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33159/tests/v8_7/run.html (next: http://localhost:33159/tests/v8_7/run.html) 10:10:27 INFO - 2015-11-16 10:10:27,849 DEBUG : BROWSER_OUTPUT: RSS: Main: 137342976 10:10:27 INFO - 2015-11-16 10:10:27,849 DEBUG : BROWSER_OUTPUT: 10:10:27 INFO - 2015-11-16 10:10:27,849 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:10:27 INFO - 2015-11-16 10:10:27,850 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:10:27 INFO - 2015-11-16 10:10:27,850 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:10:27 INFO - 2015-11-16 10:10:27,850 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:10:27 INFO - 2015-11-16 10:10:27,850 DEBUG : BROWSER_OUTPUT: |0;Richards;162.2586402725945 10:10:27 INFO - 2015-11-16 10:10:27,850 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;196.23233908948194 10:10:27 INFO - 2015-11-16 10:10:27,850 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.7142857142857 10:10:27 INFO - 2015-11-16 10:10:27,850 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 10:10:27 INFO - 2015-11-16 10:10:27,850 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1062.6992561105208 10:10:27 INFO - 2015-11-16 10:10:27,850 DEBUG : BROWSER_OUTPUT: |5;Earley;722.0216606498195 10:10:27 INFO - 2015-11-16 10:10:27,850 DEBUG : BROWSER_OUTPUT: |6;Boyer;12219.512195121952 10:10:27 INFO - 2015-11-16 10:10:27,851 DEBUG : BROWSER_OUTPUT: |7;RegExp;25150 10:10:27 INFO - 2015-11-16 10:10:27,851 DEBUG : BROWSER_OUTPUT: |8;Splay;626.1740763932373 10:10:27 INFO - 2015-11-16 10:10:27,851 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 10:10:27 INFO - 2015-11-16 10:10:27,851 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:10:27 INFO - 2015-11-16 10:10:27,851 DEBUG : BROWSER_OUTPUT: __startTimestamp1447697427842__endTimestamp 10:10:27 INFO - 2015-11-16 10:10:27,851 DEBUG : BROWSER_OUTPUT: 10:10:27 INFO - 2015-11-16 10:10:27,851 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:10:27 INFO - 2015-11-16 10:10:27,851 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:10:27 INFO - 2015-11-16 10:10:27,851 DEBUG : BROWSER_OUTPUT: 10:10:27 INFO - 2015-11-16 10:10:27,851 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.26 Median:162.26 stddev:0.00 (0.0%) 10:10:27 INFO - 2015-11-16 10:10:27,852 DEBUG : BROWSER_OUTPUT: Values: 162.3 10:10:27 INFO - 2015-11-16 10:10:27,852 DEBUG : BROWSER_OUTPUT: 10:10:27 INFO - 2015-11-16 10:10:27,852 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:196.23 Median:196.23 stddev:0.00 (0.0%) 10:10:27 INFO - 2015-11-16 10:10:27,852 DEBUG : BROWSER_OUTPUT: Values: 196.2 10:10:27 INFO - 2015-11-16 10:10:27,852 DEBUG : BROWSER_OUTPUT: 10:10:27 INFO - 2015-11-16 10:10:27,852 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.71 Median:285.71 stddev:0.00 (0.0%) 10:10:27 INFO - 2015-11-16 10:10:27,852 DEBUG : BROWSER_OUTPUT: Values: 285.7 10:10:27 INFO - 2015-11-16 10:10:27,852 DEBUG : BROWSER_OUTPUT: 10:10:27 INFO - 2015-11-16 10:10:27,852 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 10:10:27 INFO - 2015-11-16 10:10:27,852 DEBUG : BROWSER_OUTPUT: Values: 5040.2 10:10:27 INFO - 2015-11-16 10:10:27,853 DEBUG : BROWSER_OUTPUT: 10:10:27 INFO - 2015-11-16 10:10:27,853 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1062.70 Median:1062.70 stddev:0.00 (0.0%) 10:10:27 INFO - 2015-11-16 10:10:27,853 DEBUG : BROWSER_OUTPUT: Values: 1062.7 10:10:27 INFO - 2015-11-16 10:10:27,853 DEBUG : BROWSER_OUTPUT: 10:10:27 INFO - 2015-11-16 10:10:27,853 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:722.02 Median:722.02 stddev:0.00 (0.0%) 10:10:27 INFO - 2015-11-16 10:10:27,853 DEBUG : BROWSER_OUTPUT: Values: 722.0 10:10:27 INFO - 2015-11-16 10:10:27,853 DEBUG : BROWSER_OUTPUT: 10:10:27 INFO - 2015-11-16 10:10:27,853 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 10:10:27 INFO - 2015-11-16 10:10:27,853 DEBUG : BROWSER_OUTPUT: Values: 12219.5 10:10:27 INFO - 2015-11-16 10:10:27,853 DEBUG : BROWSER_OUTPUT: 10:10:27 INFO - 2015-11-16 10:10:27,853 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25150.00 Median:25150.00 stddev:0.00 (0.0%) 10:10:27 INFO - 2015-11-16 10:10:27,853 DEBUG : BROWSER_OUTPUT: Values: 25150.0 10:10:27 INFO - 2015-11-16 10:10:27,853 DEBUG : BROWSER_OUTPUT: 10:10:27 INFO - 2015-11-16 10:10:27,853 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:626.17 Median:626.17 stddev:0.00 (0.0%) 10:10:27 INFO - 2015-11-16 10:10:27,853 DEBUG : BROWSER_OUTPUT: Values: 626.2 10:10:27 INFO - 2015-11-16 10:10:27,854 DEBUG : BROWSER_OUTPUT: 10:10:27 INFO - 2015-11-16 10:10:27,854 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 10:10:27 INFO - 2015-11-16 10:10:27,854 DEBUG : BROWSER_OUTPUT: Values: 4822.1 10:10:27 INFO - 2015-11-16 10:10:27,854 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:10:27 INFO - 2015-11-16 10:10:27,854 DEBUG : BROWSER_OUTPUT: 10:10:28 INFO - 2015-11-16 10:10:28,864 INFO : Browser exited with error code: 0 10:10:28 INFO - 2015-11-16 10:10:28,881 INFO : Completed test v8_7 (00:00:40) 10:10:29 INFO - 2015-11-16 10:10:29,370 INFO : Completed test suite (00:20:11) 10:10:29 INFO - 2015-11-16 10:10:29,370 DEBUG : Working with test: dromaeo_css 10:10:29 INFO - 2015-11-16 10:10:29,370 DEBUG : Generating results file: dromaeo_css 10:10:29 INFO - 2015-11-16 10:10:29,372 DEBUG : Working with test: kraken 10:10:29 INFO - 2015-11-16 10:10:29,372 DEBUG : Generating results file: kraken 10:10:29 INFO - 2015-11-16 10:10:29,372 INFO : javascript benchmark 10:10:29 INFO - 2015-11-16 10:10:29,372 DEBUG : Working with test: v8_7 10:10:29 INFO - 2015-11-16 10:10:29,372 DEBUG : Generating results file: v8_7 10:10:29 INFO - 2015-11-16 10:10:29,373 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:10:29 INFO - 2015-11-16 10:10:29,433 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 10:10:29 INFO - 2015-11-16 10:10:29,433 DEBUG : process_Request line: dromaeo_css 6625.74 graph.html#tests=[[72,1,43]] 10:10:29 INFO - 2015-11-16 10:10:29,433 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:10:29 INFO - 2015-11-16 10:10:29,466 DEBUG : process_Request line: kraken 1505.80 graph.html#tests=[[232,1,43]] 10:10:29 INFO - 2015-11-16 10:10:29,466 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:10:29 INFO - 2015-11-16 10:10:29,497 DEBUG : process_Request line: v8_7 21284.04 graph.html#tests=[[230,1,43]] 10:10:29 INFO - 2015-11-16 10:10:29,499 INFO : javascript benchmark 10:10:29 INFO - 2015-11-16 10:10:29,502 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [347.4475583821723, 347.846947343169, 349.3746194312178, 350.98947031589046, 351.39209168139126, 12114.575989840358, 12505.0, 16656.333746650118, 16869.746953795686, 17721.556961075963, 11517.251378660401, 11567.363794991272, 11588.942055289734, 11629.185956983014, 11701.18091733579, 4431.290993441042, 4580.221362368388, 4585.793639286224, 4608.907821843561, 4610.0, 4463.085067561142, 4567.817287308504, 4607.7004994675235, 4614.492405835355, 4619.422572178478, 4557.179707652621, 4557.498675145731, 4574.748388838612, 4653.348531205634, 4653.534646535336, 4700.4594471635855, 4744.264638980963, 4752.52474752522, 4769.833055843029, 4793.137235297645, 4145.108801607638, 4280.122574872144, 4288.399624052635, 4290.377895205178, 4301.075268817188, 13270.668233294246, 13298.0, 13491.190528568317, 13727.0, 13856.861431385658, 1862.4319582527323, 1963.9312624058089, 1964.7838737738837, 2015.0730663894626, 2047.3653167518116, 9514.28642851789, 9856.457894815781, 9885.456299903502, 9888.802223955552, 9935.751606209831, 1698.9975914210675, 1704.3523461084833, 1713.468824664358, 1737.6350966297093, 1743.2678275124479, 62054.37945620577, 62075.0, 62704.37295627031, 62829.0, 63873.361266387205, 7104.609246491389, 7108.822279442952, 7122.430205583541, 7136.143662760398, 7159.57042577447, 8429.662813487514, 8439.409241353169, 8450.281726053232, 8450.450720703135, 8453.154684531497, 5714.914276285859, 5775.335836378787, 5775.797847075416, 5802.564807639444, 5812.564057695689, 5565.552956231409, 5628.0, 5648.096304591246, 5651.095824668033, 5811.157382179645, 3244.918877028046, 3298.340331933623, 3311.569495965509, 3314.055494184146, 3335.31626016666, 1173.6068417080373, 1184.5853951117213, 1188.8632807227107, 1192.9045676345872, 1224.222618637154, 431.4692927698885, 465.9603933665609, 467.1591135955335, 467.4810959834581, 507.713142074734, 11259.0, 11430.371329576787, 11713.941430292964, 11750.118741094451, 11964.88035119655, 483.43196743825865, 491.7123482762552, 495.90825697246123, 505.6536272653244, 509.5363219470264, 5528.530074943675, 6505.414512693786, 6507.511936604679, 6573.112629795012, 6574.572652777554, 545394.0, 554993.0, 558023.0988450561, 566738.0, 568295.0, 68329.0, 69990.65004674943, 72573.63713181506, 75362.24637753662, 77535.61232193916, 545.1414022913847, 553.6705660132214, 556.666000399765, 556.9192467092249, 558.6145559563888, 10775.94612026935, 10860.945695271474, 10907.345559266469, 11053.668389948314, 11155.0, 34462.0, 36249.81875090607, 37257.62742372542, 37433.0, 37783.43324850075, 44646.55353446424, 44750.552494474636, 46222.768886155354, 47660.0, 51870.481295188074, 6623.2383275923885, 6736.090627765189, 6802.0, 6871.828204294932, 6909.7581584644295, 12156.0, 12415.503379864704, 12419.130660853654, 12499.687507812378, 12609.810852837398, 10216.54025568866, 10384.688459346231, 10487.161027117965, 10845.186611004365, 10862.619808306672, 10266.43534605574, 10587.682369528926, 10664.306820056981, 10710.571577136827, 10889.0, 10473.266871318934, 10512.0, 10699.679009629723, 10901.781964360827, 10904.563817447213, 6809.148856392951, 6814.591124532544, 6942.409895158968, 6943.79168624942, 6960.095187625576, 10685.839712404164, 10799.784004319712, 10878.564857405616, 10955.780884382108, 11060.446977650925], "dojo.html": [3161.9051428457146, 3191.313867518483, 3207.326461443097, 3232.579764630598, 3233.5958005249345, 5107.055194788966, 5126.794928202872, 5193.350831146102, 5224.138017227157, 5228.4771522847695, 5177.094008548508, 5193.091209038422, 5225.555827754645, 5316.388615309241, 5327.547158491523, 4808.783604737795, 4870.634702397317, 4917.164082106033, 4934.654574179809, 4996.1756310208775, 4849.442314133867, 4922.8523144305545, 4948.307236986825, 4992.850214493571, 5022.472640372763, 4758.119747846642, 4781.0, 4864.586510146624, 4901.730404827733, 4917.385326834145, 4800.135975524404, 4803.543663352011, 4817.0, 4831.420229572439, 4836.443808961944, 4626.9074618507775, 4780.235162374003, 4794.161021821167, 4798.256270278112, 4829.661923665345, 5055.721935293557, 5058.747062646853, 5059.0, 5103.974480127613, 5139.717315547643, 5687.0900655895275, 5722.256106706143, 5735.139729040636, 5747.195392645033, 5754.194412782172, 5612.186232996233, 5677.148427735831, 5744.942550574483, 5766.884662306772, 5788.913166302509, 5244.292020577212, 5298.496642818926, 5308.0710875596615, 5321.175217841241, 5372.892542149174, 5769.68266745333, 5789.102689083199, 5831.475167234885, 5833.416658334133, 5842.298924129132, 5390.380106287748, 5484.643498172686, 5490.121580547093, 5609.971950140223, 5614.9719251403485, 5706.71466426677, 5716.79991200306, 5744.0, 5757.222774925415, 5760.683162426023, 5705.5435565154685, 5714.685692286964, 5719.0, 5725.940700970334, 5733.0540460823495, 5463.235147079412, 5567.331920169606, 5595.356533998561, 5695.857603559944, 5713.5714821388565, 4394.626456751148, 4408.647308215399, 4417.028253784162, 4423.756693381831, 4442.68901176921, 3939.684825213976, 3954.307996100671, 3956.0703234739813, 3966.7223294369696, 3992.1416895367634, 5309.46905309466, 5319.654222475527, 5396.78412863481, 5416.864578385572, 5478.753456094485, 5627.493525582717, 5644.97177514118, 5670.0, 5693.231413759089, 5709.8287051388525, 5325.813596524181, 5441.347038355423, 5461.344638643309, 5482.643628164236, 5501.449855014546, 4915.508449155127, 4938.08645400602, 4949.752512374367, 4984.675996060245, 5032.169692000779, 5997.520198384206, 6022.879542409128, 6031.668258245751, 6040.848978775478, 6054.122152287893, 5553.916691249554, 5668.574856885833, 5755.165501002248, 5756.625819321731, 5760.798372056958, 5841.50347220474, 5929.762809487572, 5929.940700592939, 5935.436133567304, 5974.61165024272, 5562.3047119110115, 5610.943890561205, 5612.607117501899, 5621.80323688669, 5635.436456354331, 5449.809256675997, 5568.498835104698, 5588.273524441796, 5712.885742285214, 5729.4843464088435, 5314.362276526842, 5418.539424148834, 5449.482299181572, 5502.669839809624, 5510.393856675682, 5475.260839786578, 5502.284702988586, 5511.862203444946, 5515.117581186991, 5525.171224316385, 5332.413434522277, 5410.59420543453, 5410.621256512007, 5422.5119739223655, 5472.2338872557075, 5420.945790542044, 5498.3127109111365, 5498.532624726943, 5502.0371434999515, 5508.0, 5459.0, 5468.781248750005, 5519.834404967857, 5522.530584900168, 5523.199136125159], "mootools.html": [1486.026652542585, 1755.5962128710396, 1799.181372475523, 1816.4550634809555, 1820.817918208179, 7236.421086313096, 7421.443391745621, 7428.628568571577, 7434.1822399536, 7607.315341619254, 7688.308052275294, 7719.266669666386, 7720.189380115077, 7797.220277972214, 7800.609969501516, 2265.796078352952, 2272.5909336319455, 2288.7596802335765, 2293.220305096267, 2294.8737819420007, 2269.841111122222, 2297.425643589103, 2310.7689231076843, 2314.1668999160374, 2319.6288593824993, 1957.2660252405349, 1993.6710442776925, 2186.6282731935607, 2258.390234636647, 2293.036924491709, 2171.6742488626674, 2178.2485042660255, 2181.4873504726374, 2182.8690278583335, 2183.399565119581, 2171.4788450771857, 2257.604919139144, 2264.5810525052916, 2266.195500597281, 2271.9889649106153, 7521.924780752177, 7548.358389536841, 7580.924190758077, 7601.961990190069, 7610.657520411595, 4610.147122782296, 4642.837500687494, 4719.38647975761, 4726.432828060655, 4731.834385796515, 2920.4889144399644, 2928.6046383738135, 2979.7765167612515, 2999.7450216731604, 3001.2046807596003, 928.3779867488731, 936.6721647423416, 954.8663187153804, 969.1035791892472, 981.6515137126289, 10274.126699230574, 10352.48237588125, 10396.844047339297, 10411.791764164751, 10423.895761042368, 4159.708820382604, 4196.769177695195, 4277.144571085795, 4285.421468101828, 4293.184294983943, 8378.413511054168, 8502.319814414832, 8513.74458766238, 8519.275861551714, 8562.357823163287, 4661.254199328091, 4701.2242979908615, 4716.9292460613115, 4719.882002949954, 4742.07529531738, 4283.485981682155, 4317.438732964694, 4321.503027151855, 4346.348047792793, 4349.412829268072, 3369.124027752802, 3451.3960056989927, 3459.2043829919257, 3462.4460086386057, 3481.7562770605814, 1047.8009178256107, 1058.169337070396, 1066.1044722433194, 1084.4252546150553, 1101.7851518953887, 988.1501908358806, 1040.7918416316768, 1049.1397054415459, 1178.9823152652716, 1340.919544827294, 7038.753643622551, 7101.0, 7106.573605583578, 7112.288771122846, 7140.500164988505, 1116.8157254053153, 1143.6454699043322, 1149.1209224942925, 1149.3219000789575, 1173.342927960345, 5604.6917419541505, 5635.5773317001385, 5662.773489060474, 5698.971505142447, 5706.771729130871, 8769.517676527852, 8885.111488851193, 9138.680146194984, 9272.350935434455, 9277.443353398683, 9045.050269721716, 9078.86381704275, 9086.045965173695, 9089.545522723838, 9159.267258619295, 6996.090508233897, 7074.080369552028, 7102.715891364391, 7113.7154513819905, 7132.643367831588, 6809.250982392032, 6841.726330946706, 6862.176538815374, 6863.965680171567, 6897.517173797786, 7798.298153166243, 7961.243681850215, 8031.879521807061, 8113.797155071171, 8114.634841432032, 8115.75652730419, 8286.668533258602, 8304.958475207586, 8329.333653307842, 8354.749357519284, 6670.59976401398, 6784.05023296729, 6863.828404289933, 6895.586264824126, 6931.133608298963, 7347.33873951347, 7405.851882962203, 7408.6666100026705, 7428.925710742823, 7430.739924102847, 6889.655517224019, 6967.686454109476, 7021.368076873106, 7135.678894449658, 7182.784516464514, 6693.196816382066, 6718.899216511854, 6804.897926531007, 6839.452843772586, 6957.478189135733, 6767.323267673193, 6975.1978522468535, 7055.894161587477, 7062.0, 7065.57606543609, 6173.660448675366, 6257.906131408124, 6260.154879091265, 6268.498520118471, 6292.559520833681, 6515.73937042532, 6552.934470655233, 6557.344265573404, 6573.638449885302, 6576.638284894377], "ext.html": [592.1768741449387, 597.825273337891, 608.5679167790868, 613.656352442632, 646.092240402235, 39317.0, 40072.19855602886, 40235.1952960941, 40241.99395015119, 40443.39334909979, 40535.391969120414, 41225.79387103068, 41505.0, 41612.0, 41690.0, 8700.477971321725, 8804.735857924272, 8813.60338784753, 8864.512451815148, 8886.4668119913, 8560.571971401436, 8593.95703021484, 8627.568621568927, 8673.95663021684, 8680.435771674853, 8576.69981550646, 8597.18326758957, 8630.352723545759, 8639.265662418702, 8694.087120852282, 8602.87095693565, 8607.39748217625, 8634.222919937205, 8684.0, 8695.130486951255, 8419.915800841974, 8487.151284871525, 8505.74482765518, 8582.656693732244, 8627.051024387312, 38939.22121557553, 39471.40792888109, 39482.407763883566, 39509.802450987845, 39530.20939581192, 3042.0, 3103.425866214735, 3232.4343239933155, 3268.7385009199443, 3269.5095735639607, 30218.69781302181, 30368.088957331314, 30503.23741906448, 30598.38803223923, 30747.538786918216, 3377.1725927148004, 3389.4915762635555, 3391.186115332327, 3466.532018177539, 3539.2036791721657, 271589.0, 272622.0, 274864.0, 275002.0, 275616.0, 42206.577934220266, 42761.35857962133, 42854.35718464226, 57916.42083579195, 58205.708971455715, 40975.59024409777, 40979.0, 40997.180056398705, 41117.58882411138, 41255.0, 14477.638059048608, 14700.338484768212, 14720.0, 14724.55826325212, 14727.190004549639, 11663.066954643607, 11764.941175294069, 11765.294082355085, 11778.469968851423, 11804.940975295069, 14038.649033774238, 14089.506867259597, 14118.43526258938, 14143.29283535819, 14220.786688199685, 5819.854503637443, 5905.940940590625, 5937.80442113151, 5938.376470470625, 5985.533544281592, 878.2490970220497, 921.9262459003263, 972.3339512434005, 1098.8296813993843, 1127.8026345389524, 27648.308792280353, 27965.021224257052, 28052.71947280542, 28170.0, 28182.43635127286, 1009.6112996496402, 1014.8832884218261, 1053.2785042246087, 1103.194667892443, 1127.8195488721929, 14544.29120574268, 14573.92713036428, 14577.271136443136, 14690.63273418173, 14775.26123693811, 308804.0, 310910.0, 312824.0, 312984.0, 313689.0, 50083.74958125259, 50819.491805082216, 50860.23709644358, 50942.23586646203, 50991.74504127455, 1293.6636474516692, 1316.8419789625116, 1345.8990575706862, 1345.9232613908835, 1350.1763924006348, 25868.741312587386, 27007.1897843065, 27117.186484405498, 27379.0, 31543.684563154075, 48636.75681621569, 49642.25536617026, 49676.75161624169, 49684.50315496943, 49756.75121624369, 288126.0, 289540.0, 290501.0, 290541.0, 290980.0, 40986.38520422136, 41940.386557479265, 42018.0, 42146.78926605347, 42175.0, 42244.577554224066, 43914.0, 44037.33943990907, 44285.77857110694, 44373.77813110914, 36910.8154459226, 36986.0, 37245.6275437253, 37496.62503374931, 37698.81150594229, 37057.81471092627, 37190.25619487649, 37360.81319593385, 37782.0, 39996.20007599774, 35937.0, 36304.0, 36524.63475365212, 36541.45187822131, 36635.26729465449, 32177.517337240428, 33332.1666958328, 33775.4933676, 33788.66211337855, 33916.49125263074, 25518.617220742075, 25633.74366256388, 25659.743402565735, 25913.352166195997, 26194.476110478066], "prototype.html": [317.8267844025006, 321.7860123018193, 322.9564008858805, 325.68896703648016, 327.91802049487626, 6115.633062016283, 6208.596441231317, 6214.378562143784, 6259.780907668232, 6322.241331040282, 6080.270367555889, 6130.2643682758135, 6151.938480615193, 6174.073888916665, 6194.256689197291, 4531.818727250906, 4683.7892294846815, 4688.976555117237, 4697.154512187805, 4708.128996135726, 4694.671373003891, 4706.882327941795, 4712.5523075307965, 4718.245080787075, 4722.622190224791, 4646.767661616923, 4663.48701642819, 4663.790129444184, 4667.7199368037855, 4668.299755036738, 4628.652851036169, 4640.930386044212, 4661.46393164787, 4666.53334666534, 4675.7895894684825, 3965.8413663453425, 4063.3295506241434, 4088.366303223005, 4093.44738460307, 4095.7747323897174, 5768.913466298009, 5835.241418615553, 5837.795677151279, 5840.065589505659, 5875.324337701177, 5395.271638328814, 5409.323834520685, 5411.242426060355, 5418.431064738185, 5424.240606315119, 6463.612183269019, 6466.062420948983, 6466.094746735461, 6492.448141907897, 6507.414332710079, 4392.802323895432, 4486.977565112186, 4488.663350248745, 4490.910181796378, 4498.820047198108, 6798.830029249259, 6863.553868998499, 6880.105586273752, 6886.655667216619, 6895.275996020446, 4581.656375771764, 4614.792334344963, 4622.168009758276, 4641.767911604406, 4642.187617166982, 4575.0, 4620.584147426748, 4642.326862604903, 4649.256119020941, 4678.134545109166, 5381.461853814587, 5387.595930305164, 5390.51485366319, 5391.919121213185, 5397.190421436816, 6593.7362505500205, 6610.7025183866845, 6620.073189753439, 6623.9006414903815, 6660.134182556333, 1649.2990479046598, 1662.758899959499, 1664.0847533856331, 1664.3259479910655, 1667.4414071286255, 1099.2525082943675, 1103.5530610102921, 1108.9778204435866, 1127.1208457403238, 1130.8642962844347, 6357.554971151975, 6471.288158302583, 6477.060826180177, 6478.870422591522, 6515.348465153542, 6814.841476948931, 6819.659017049128, 6832.658367081626, 6870.141232345957, 6877.140357455318, 6468.288488266287, 6469.417752402306, 6470.741170353227, 6511.186101737283, 6538.1827271591055, 3630.8910732678064, 3700.2229531798084, 3725.515682961198, 3730.0, 3756.1173124315765, 7278.672459739324, 7301.050863387832, 7324.853502930018, 7335.1564570075125, 7339.559626422431, 7033.191183013917, 7055.153381594241, 7063.364297213173, 7075.646217689095, 7084.397826184729, 7210.495265331377, 7237.565746055254, 7321.414286857039, 7322.0847394075745, 7327.45044121693, 6849.486288528281, 6860.5540639858245, 6872.759453419107, 6878.793636190922, 6884.48366372514, 6779.288174741581, 6799.082123913407, 6806.42145417645, 6812.352826481477, 6814.284500127415, 7069.151701795818, 7293.562386256842, 7308.342249197598, 7327.63361831917, 7328.890066649111, 4433.623142032834, 4456.398386217819, 4459.531749166291, 4463.062756821104, 4466.486354069194, 6871.553349032297, 6874.553154044971, 6876.415504682158, 6893.655317234218, 6895.724171033103, 6477.805665829844, 6671.499637527302, 6675.632840193836, 6681.29846366144, 6689.933100668931, 6610.933890661032, 6664.0670306158145, 6672.666366681744, 6673.399394054559, 6691.899621505584, 6463.192100987377, 6493.545451818327, 6496.285408605144, 6515.54391192612, 6519.902201467076, 6504.284528701934, 6510.73957041713, 6630.336966303331, 6677.599344039373, 6681.33186681328, 6455.580387274812, 6466.579672321284, 6494.2856285807575, 6497.382748638872, 6507.544471886922], "yui.html": [753.9773806785798, 768.665630450754, 787.6258777080885, 848.716951400732, 875.6366108065151, 14094.815303627942, 14595.92702036491, 14598.343074561644, 14697.04469209502, 14706.264686765673, 13545.255010974393, 13654.52209172679, 13683.726325473484, 13687.452501899912, 13704.0, 806.5604245686116, 807.2049031703767, 810.8094597769519, 823.6170180865926, 824.0729179672868, 817.0, 819.3117781063905, 820.8932838730957, 821.7411515372638, 824.3981893217955, 848.4909054567272, 854.1245223645751, 855.2345650642702, 857.6697971281039, 859.1623167411786, 835.9623816928253, 836.1638361638362, 840.2269911681207, 842.1326034184799, 846.3652260804397, 615.3292910727284, 616.5714828194407, 617.3579477343558, 618.2395653346409, 619.2630769384418, 13734.107283026671, 13785.931070344684, 13861.23763193024, 13877.0, 13932.651683707887, 10165.237607179492, 10316.1747060235, 10343.844842327371, 10505.4222017789, 10610.151187904949, 9718.854217186748, 9871.950640246752, 10106.242031847642, 10250.897491025144, 10646.57413703451, 3205.1537358610813, 3273.4435146025235, 3274.197821533716, 3282.917927051819, 3373.122988023107, 46084.53915460836, 46276.53723462756, 47377.0, 47633.28550071752, 47697.28454073192, 7456.589887556128, 7506.3244308012545, 7556.735514257085, 7670.309672129423, 7749.147593764681, 11159.274647148071, 11278.210525263154, 11296.378699171624, 11301.943490282496, 11321.264117832314, 6524.347565243438, 6575.638339891256, 6625.469962402996, 6727.327267273234, 6830.59016459014, 4478.529754375743, 4502.797374118172, 4524.343970124313, 4534.841280555164, 4605.032943081923, 2730.945381092407, 2741.931451713723, 2758.5724212747054, 2766.806323557332, 2767.501849667079, 414.9024979129902, 417.7827529684547, 420.56471551943594, 421.44158989339246, 429.10745649050523, 605.4006533531859, 623.3890787028737, 635.3265538529174, 668.8929771236578, 674.9055132281485, 8564.3148548116, 8798.164174403422, 9091.27269818413, 9279.582418791171, 9289.34974551775, 576.2105914896619, 583.2796496327032, 647.6373230990566, 655.4101308822003, 706.9469789765789, 4023.155137421116, 4092.5498195199098, 4358.389825424443, 4395.384646149541, 4401.6698747594055, 57852.71073644689, 57936.0, 57986.420135798944, 58184.41815581875, 58541.41458585445, 53013.204801928005, 53436.46563534315, 53505.464945350825, 53736.193957090676, 53927.730361347945, 45116.3232551512, 47184.7640761794, 47343.52656473391, 47606.04787904223, 47894.76052619715, 8220.876686849822, 8376.49741015541, 8489.10864359258, 8562.657493700182, 8584.141585841615, 33744.49383259204, 33944.66055339415, 34122.317553649285, 34205.48691769576, 34377.48433773445, 41367.58632413638, 41887.0, 45153.774231128635, 46026.53973460222, 46195.0, 7105.111861017373, 7370.77887663371, 7388.224236455095, 7399.334059934632, 7501.512401693873, 11602.0, 11764.647060588197, 11883.227590206609, 11975.101867360157, 12136.0, 10361.948190259, 10398.68803935883, 10427.165826733995, 10498.842517362398, 10600.522976466233, 10630.574777009142, 10783.946080269863, 10950.178736594627, 10979.670609881716, 11274.154438416988, 9956.20350371983, 10059.497025148567, 10647.094996925038, 10836.67489975302, 10849.620263290746, 8971.730848074569, 9096.77258068527, 9154.725358239264, 9379.765505862408, 9469.810603788024, 9056.1687198421, 9382.437053776795, 9748.9025109748, 9798.85301720489, 9985.60057597688]}, "summary": {"lowerIsBetter": false, "suite": 6625.737293117318, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6884.682936683555, "unit": "ms", "value": 6884.682936683555}, "dojo.html": {"lowerIsBetter": false, "filtered": 5241.983448965266, "unit": "ms", "value": 5241.983448965266}, "mootools.html": {"lowerIsBetter": false, "filtered": 4401.140013723566, "unit": "ms", "value": 4401.140013723566}, "ext.html": {"lowerIsBetter": false, "filtered": 17987.1965094679, "unit": "ms", "value": 17987.1965094679}, "prototype.html": {"lowerIsBetter": false, "filtered": 4960.417069503685, "unit": "ms", "value": 4960.417069503685}, "yui.html": {"lowerIsBetter": false, "filtered": 5969.570143635434, "unit": "ms", "value": 5969.570143635434}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-037.e"}, "testrun": {"date": 1447696217, "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": "20151116073034", "branch": "Firefox", "revision": "4294bf91174b71ed7440dc491dac5d15394ec227"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 161.0, 161.0, 163.0, 161.0, 162.0, 162.0, 165.0, 169.0, 162.0], "ai-astar": [113.0, 105.0, 112.0, 110.0, 111.0, 123.0, 109.0, 112.0, 112.0, 110.0], "imaging-gaussian-blur": [110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 111.0, 110.0], "audio-beat-detection": [150.0, 128.0, 149.0, 164.0, 139.0, 153.0, 149.0, 128.0, 159.0, 127.0], "json-stringify-tinderbox": [69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 70.0, 69.0], "stanford-crypto-pbkdf2": [141.0, 154.0, 149.0, 159.0, 151.0, 139.0, 156.0, 154.0, 143.0, 139.0], "json-parse-financial": [61.0, 65.0, 62.0, 61.0, 63.0, 66.0, 62.0, 61.0, 60.0, 59.0], "stanford-crypto-sha256-iterative": [68.0, 67.0, 66.0, 68.0, 65.0, 67.0, 68.0, 67.0, 66.0, 67.0], "audio-fft": [73.0, 72.0, 73.0, 72.0, 74.0, 138.0, 72.0, 72.0, 71.0, 71.0], "imaging-darkroom": [148.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0], "stanford-crypto-ccm": [132.0, 118.0, 116.0, 121.0, 125.0, 117.0, 119.0, 117.0, 120.0, 126.0], "audio-oscillator": [89.0, 90.0, 136.0, 89.0, 90.0, 91.0, 129.0, 89.0, 94.0, 131.0], "stanford-crypto-aes": [83.0, 83.0, 92.0, 85.0, 83.0, 84.0, 83.0, 85.0, 85.0, 88.0], "imaging-desaturate": [96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1505.8, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 78.8, "unit": "ms", "value": 78.8}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 148.5, "unit": "ms", "value": 148.5}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 144.6, "unit": "ms", "value": 144.6}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 121.1, "unit": "ms", "value": 121.1}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 146.6, "unit": "ms", "value": 146.6}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 62.0, "unit": "ms", "value": 62.0}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 102.8, "unit": "ms", "value": 102.8}, "ai-astar": {"lowerIsBetter": true, "filtered": 111.7, "unit": "ms", "value": 111.7}, "audio-dft": {"lowerIsBetter": true, "filtered": 162.8, "unit": "ms", "value": 162.8}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 66.9, "unit": "ms", "value": 66.9}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.1, "unit": "ms", "value": 69.1}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.7, "unit": "ms", "value": 109.7}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.1, "unit": "ms", "value": 85.1}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.1, "unit": "ms", "value": 96.1}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-037.e"}, "testrun": {"date": 1447696217, "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": "20151116073034", "branch": "Firefox", "revision": "4294bf91174b71ed7440dc491dac5d15394ec227"}}, {"talos_counters": {}, "results": {"DeltaBlue": [196.23233908948194], "Encrypt": [285.7142857142857], "NavierStokes": [4822.115384615385], "Decrypt": [5040.201005025126], "Splay": [626.1740763932373], "Richards": [162.2586402725945], "RegExp": [25150.0], "Earley": [722.0216606498195], "Boyer": [12219.512195121952], "RayTrace": [1062.6992561105208]}, "summary": {"lowerIsBetter": false, "suite": 21284.040134406398, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 336.9373280000001, "unit": "score", "value": 336.9373280000001}, "Encrypt": {"lowerIsBetter": false, "filtered": 931.6335000000004, "unit": "score", "value": 931.6335000000004}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.7487537387835, "unit": "score", "value": 307.7487537387835}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.81158424725827, "unit": "score", "value": 52.81158424725827}, "Splay": {"lowerIsBetter": false, "filtered": 130.141127, "unit": "score", "value": 130.141127}, "RegExp": {"lowerIsBetter": false, "filtered": 36.22206759443341, "unit": "score", "value": 36.22206759443341}, "Richards": {"lowerIsBetter": false, "filtered": 217.56622599999994, "unit": "score", "value": 217.56622599999994}, "Earley": {"lowerIsBetter": false, "filtered": 923.0512549999999, "unit": "score", "value": 923.0512549999999}, "Boyer": {"lowerIsBetter": false, "filtered": 54.540884231536886, "unit": "score", "value": 54.540884231536886}, "RayTrace": {"lowerIsBetter": false, "filtered": 696.3296489999998, "unit": "score", "value": 696.3296489999998}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-037.e"}, "testrun": {"date": 1447696217, "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": "20151116073034", "branch": "Firefox", "revision": "4294bf91174b71ed7440dc491dac5d15394ec227"}}] 10:10:29 INFO - RETURN: dromaeo_css: 6625.74 10:10:29 INFO - RETURN: kraken: 1505.80 10:10:29 INFO - RETURN: v8_7: 21284.04 10:10:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "21284.04"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1505.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6625.74"}}} 10:10:29 INFO - Return code: 0 10:10:29 INFO - # TBPL SUCCESS # 10:10:29 INFO - Running post-action listener: _resource_record_post_action 10:10:29 INFO - Running post-run listener: _resource_record_post_run 10:10:30 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 20480; Write bytes: 523509760; Read time: 428; Write time: 463652 10:10:30 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 105205760; Read time: 0; Write time: 64912 10:10:30 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 20480; Write bytes: 355020800; Read time: 428; Write time: 289540 10:10:30 INFO - Running post-run listener: _upload_blobber_files 10:10:30 INFO - Blob upload gear active. 10:10:30 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:10:30 INFO - Copying logs to upload dir... 10:10:30 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1257.082837 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2015-11-16 10:10:30.571457) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 10:10:30.575197) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1447692795.66995-1538703239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/FBWy8FvOTJaUdxdmhI5i3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009909 build_url: 'https://queue.taskcluster.net/v1/task/FBWy8FvOTJaUdxdmhI5i3A/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-16 10:10:30.626868) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 10:10:30.627206) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1447692795.66995-1538703239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 10:10:30.676563) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 10:10:30.676881) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 10:10:30.677177) ========= ========= Total master_lag: 0.18 =========