builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-054 starttime: 1447966893.45 results: success (0) buildid: 20151119113006 builduid: e41244028f794a64b3b1a4c32037dafb revision: 5732e276c41ce1e771d4d550e8a95afdd9a2b105 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 13:01:33.445538) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 13:01:33.445994) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 13:01:33.446336) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1447964726.328778-1913886165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004505 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 13:01:33.467353) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 13:01:33.467707) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 13:01:33.531421) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 13:01:33.531872) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1447964726.328778-1913886165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.025633 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 13:01:33.627192) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 13:01:33.627508) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 13:01:33.627902) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 13:01:33.628182) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1447964726.328778-1913886165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-19 13:01:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 215M=0s 2015-11-19 13:01:33 (215 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159335 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 13:01:33.823424) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 13:01:33.823797) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1447964726.328778-1913886165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.123266 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 13:01:33.958915) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 13:01:33.959277) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5732e276c41ce1e771d4d550e8a95afdd9a2b105 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 5732e276c41ce1e771d4d550e8a95afdd9a2b105 --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=752f8c75933e5bfb3b8f10bb000001ce-1447964726.328778-1913886165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-19 13:01:34,123 truncating revision to first 12 chars 2015-11-19 13:01:34,123 Setting DEBUG logging. 2015-11-19 13:01:34,123 attempt 1/10 2015-11-19 13:01:34,123 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5732e276c41c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 13:01:34,380 unpacking tar archive at: fx-team-5732e276c41c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.549593 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 13:01:34.520764) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 13:01:34.521040) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 13:01:34.531028) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 13:01:34.531283) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 13:01:34.531663) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 52 secs) (at 2015-11-19 13:01:34.531978) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=752f8c75933e5bfb3b8f10bb000001ce-1447964726.328778-1913886165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:01:34 INFO - MultiFileLogger online at 20151119 13:01:34 in /builds/slave/test-pgo 13:01:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 13:01:34 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:01:34 INFO - {'append_to_log': False, 13:01:34 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:01:34 INFO - 'blob_upload_branch': 'Fx-Team', 13:01:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:01:34 INFO - 'branch': 'Fx-Team', 13:01:34 INFO - 'buildbot_json_path': 'buildprops.json', 13:01:34 INFO - 'config_files': ('talos/linux_config.py',), 13:01:34 INFO - 'default_actions': ('clobber', 13:01:34 INFO - 'read-buildbot-config', 13:01:34 INFO - 'download-and-extract', 13:01:34 INFO - 'populate-webroot', 13:01:34 INFO - 'create-virtualenv', 13:01:34 INFO - 'install', 13:01:34 INFO - 'run-tests'), 13:01:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:01:34 INFO - 'download_minidump_stackwalk': True, 13:01:34 INFO - 'download_symbols': 'ondemand', 13:01:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:01:34 INFO - 'tooltool.py': '/tools/tooltool.py', 13:01:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:01:34 INFO - '/tools/misc-python/virtualenv.py')}, 13:01:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:01:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:01:34 INFO - 'installer_path': 'installer.exe', 13:01:34 INFO - 'log_level': 'info', 13:01:34 INFO - 'log_name': 'talos', 13:01:34 INFO - 'log_to_console': True, 13:01:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:01:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:01:34 INFO - 'opt_config_files': (), 13:01:34 INFO - 'pip_index': False, 13:01:34 INFO - 'sps_profile': False, 13:01:34 INFO - 'sps_profile_interval': 0, 13:01:34 INFO - 'suite': 'dromaeojs', 13:01:34 INFO - 'system_bits': '64', 13:01:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:01:34 INFO - 'title': 'talos-linux64-ix-054', 13:01:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:01:34 INFO - 'use_talos_json': True, 13:01:34 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:01:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:01:34 INFO - 'work_dir': 'build'} 13:01:34 INFO - ##### 13:01:34 INFO - ##### Running clobber step. 13:01:34 INFO - ##### 13:01:34 INFO - Running pre-action listener: _resource_record_pre_action 13:01:34 INFO - Running main action method: clobber 13:01:34 INFO - rmtree: /builds/slave/test-pgo/build 13:01:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:01:35 INFO - Running post-action listener: _resource_record_post_action 13:01:35 INFO - ##### 13:01:35 INFO - ##### Running read-buildbot-config step. 13:01:35 INFO - ##### 13:01:35 INFO - Running pre-action listener: _resource_record_pre_action 13:01:35 INFO - Running main action method: read_buildbot_config 13:01:35 INFO - Using buildbot properties: 13:01:35 INFO - { 13:01:35 INFO - "properties": { 13:01:35 INFO - "buildnumber": 331, 13:01:35 INFO - "product": "firefox", 13:01:35 INFO - "script_repo_revision": "production", 13:01:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:01:35 INFO - "repository": "", 13:01:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 13:01:35 INFO - "buildid": "20151119113006", 13:01:35 INFO - "slavename": "talos-linux64-ix-054", 13:01:35 INFO - "pgo_build": "True", 13:01:35 INFO - "basedir": "/builds/slave/test-pgo", 13:01:35 INFO - "project": "", 13:01:35 INFO - "platform": "ubuntu64_hw", 13:01:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:01:35 INFO - "slavebuilddir": "test", 13:01:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 13:01:35 INFO - "branch": "fx-team", 13:01:35 INFO - "repo_path": "integration/fx-team", 13:01:35 INFO - "stage_platform": "linux64-pgo", 13:01:35 INFO - "builduid": "e41244028f794a64b3b1a4c32037dafb", 13:01:35 INFO - "revision": "5732e276c41ce1e771d4d550e8a95afdd9a2b105" 13:01:35 INFO - }, 13:01:35 INFO - "sourcestamp": { 13:01:35 INFO - "repository": "", 13:01:35 INFO - "hasPatch": false, 13:01:35 INFO - "project": "", 13:01:35 INFO - "branch": "fx-team-linux64-pgo-talos", 13:01:35 INFO - "changes": [ 13:01:35 INFO - { 13:01:35 INFO - "category": null, 13:01:35 INFO - "files": [ 13:01:35 INFO - { 13:01:35 INFO - "url": null, 13:01:35 INFO - "name": "https://queue.taskcluster.net/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 13:01:35 INFO - } 13:01:35 INFO - ], 13:01:35 INFO - "repository": "", 13:01:35 INFO - "rev": "5732e276c41ce1e771d4d550e8a95afdd9a2b105", 13:01:35 INFO - "who": "sendchange", 13:01:35 INFO - "when": 1447966863, 13:01:35 INFO - "number": 6684808, 13:01:35 INFO - "comments": "", 13:01:35 INFO - "project": "", 13:01:35 INFO - "at": "Thu 19 Nov 2015 13:01:03", 13:01:35 INFO - "branch": "fx-team-linux64-pgo-talos", 13:01:35 INFO - "revlink": "", 13:01:35 INFO - "properties": [ 13:01:35 INFO - [ 13:01:35 INFO - "buildid", 13:01:35 INFO - "20151119113006", 13:01:35 INFO - "Change" 13:01:35 INFO - ], 13:01:35 INFO - [ 13:01:35 INFO - "builduid", 13:01:35 INFO - "e41244028f794a64b3b1a4c32037dafb", 13:01:35 INFO - "Change" 13:01:35 INFO - ], 13:01:35 INFO - [ 13:01:35 INFO - "pgo_build", 13:01:35 INFO - "True", 13:01:35 INFO - "Change" 13:01:35 INFO - ] 13:01:35 INFO - ], 13:01:35 INFO - "revision": "5732e276c41ce1e771d4d550e8a95afdd9a2b105" 13:01:35 INFO - } 13:01:35 INFO - ], 13:01:35 INFO - "revision": "5732e276c41ce1e771d4d550e8a95afdd9a2b105" 13:01:35 INFO - } 13:01:35 INFO - } 13:01:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 13:01:35 INFO - Running post-action listener: _resource_record_post_action 13:01:35 INFO - ##### 13:01:35 INFO - ##### Running download-and-extract step. 13:01:35 INFO - ##### 13:01:35 INFO - Running pre-action listener: _resource_record_pre_action 13:01:35 INFO - Running main action method: download_and_extract 13:01:35 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:01:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:01:35 INFO - https://queue.taskcluster.net/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:01:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/artifacts/public/build/test_packages.json 13:01:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/artifacts/public/build/test_packages.json 13:01:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 13:01:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 13:01:47 INFO - Downloaded 1302 bytes. 13:01:47 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 13:01:47 INFO - Using the following test package requirements: 13:01:47 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:01:47 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:01:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:01:47 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:01:47 INFO - u'jsshell-linux-x86_64.zip'], 13:01:47 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:01:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:01:47 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:01:47 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:01:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:01:47 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:01:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:01:47 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:01:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:01:47 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:01:47 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:01:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:01:47 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:01: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')]} 13:01:47 INFO - https://queue.taskcluster.net/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:01:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:01:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:01:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/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 13:01:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/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 13:01:54 INFO - Downloaded 22520587 bytes. 13:01:54 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 13:01:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:01:54 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 13:01:55 INFO - Return code: 0 13:01:55 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 13:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:01:55 INFO - https://queue.taskcluster.net/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:01:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:01:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:01:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/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 13:01:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/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 13:02:16 INFO - Downloaded 22520587 bytes. 13:02:16 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 13:02:16 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:02:16 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 13:02:17 INFO - Return code: 0 13:02: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')]} 13:02:17 INFO - https://queue.taskcluster.net/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:02:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:02:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:02:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/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 13:02:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/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 13:02:23 INFO - Downloaded 11130997 bytes. 13:02:23 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 13:02:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:02:23 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 13:02:23 INFO - Return code: 0 13:02:23 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')]} 13:02:23 INFO - https://queue.taskcluster.net/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:02:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:02:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:02:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/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 13:02:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/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 13:02:39 INFO - Downloaded 57335817 bytes. 13:02:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:02:39 INFO - mkdir: /builds/slave/test-pgo/properties 13:02:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:02:39 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:02:39 INFO - Contents: 13:02:39 INFO - build_url:https://queue.taskcluster.net/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:02:39 INFO - Running post-action listener: _resource_record_post_action 13:02:39 INFO - Running post-action listener: set_extra_try_arguments 13:02:39 INFO - ##### 13:02:39 INFO - ##### Running populate-webroot step. 13:02:39 INFO - ##### 13:02:39 INFO - Running pre-action listener: _resource_record_pre_action 13:02:39 INFO - Running main action method: populate_webroot 13:02:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:02:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:02:39 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 13:02:39 INFO - '../fennec_ids.txt'], 13:02:39 INFO - 'tests': ['tcheck2']}, 13:02:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:02:39 INFO - '--tppagecycles', 13:02:39 INFO - '7'], 13:02:39 INFO - 'tests': ['tsvgm']}}, 13:02:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:02:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:02:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:02:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:02:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:02:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:02:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:02:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:39 INFO - 'talos_options': ['--e10s'], 13:02:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:02:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:39 INFO - 'tests': ['damp', 'tps']}, 13:02:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:39 INFO - 'talos_options': ['--e10s'], 13:02:39 INFO - 'tests': ['damp', 'tps']}, 13:02:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:02:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:02:39 INFO - 'other': {'tests': ['a11yr', 13:02:39 INFO - 'ts_paint', 13:02:39 INFO - 'tpaint', 13:02:39 INFO - 'sessionrestore', 13:02:39 INFO - 'sessionrestore_no_auto_restore']}, 13:02:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:02:39 INFO - 'tests': ['a11yr', 13:02:39 INFO - 'ts_paint', 13:02:39 INFO - 'tpaint', 13:02:39 INFO - 'sessionrestore', 13:02:39 INFO - 'sessionrestore_no_auto_restore']}, 13:02:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:02:39 INFO - 'tests': ['a11yr', 13:02:39 INFO - 'ts_paint', 13:02:39 INFO - 'tpaint', 13:02:39 INFO - 'sessionrestore', 13:02:39 INFO - 'sessionrestore_no_auto_restore']}, 13:02:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:02:39 INFO - 'tests': ['a11yr', 13:02:39 INFO - 'ts_paint', 13:02:39 INFO - 'tpaint', 13:02:39 INFO - 'sessionrestore', 13:02:39 INFO - 'sessionrestore_no_auto_restore']}, 13:02:39 INFO - 'other_l64': {'tests': ['a11yr', 13:02:39 INFO - 'ts_paint', 13:02:39 INFO - 'tpaint', 13:02:39 INFO - 'sessionrestore', 13:02:39 INFO - 'sessionrestore_no_auto_restore']}, 13:02:39 INFO - 'other_nol64': {'tests': ['a11yr', 13:02:39 INFO - 'ts_paint', 13:02:39 INFO - 'tpaint', 13:02:39 INFO - 'sessionrestore', 13:02:39 INFO - 'sessionrestore_no_auto_restore']}, 13:02:39 INFO - 'svgr': {'tests': ['tsvgx', 13:02:39 INFO - 'tsvgr_opacity', 13:02:39 INFO - 'tart', 13:02:39 INFO - 'tscrollx', 13:02:39 INFO - 'cart']}, 13:02:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:02:39 INFO - 'tests': ['tsvgx', 13:02:39 INFO - 'tsvgr_opacity', 13:02:39 INFO - 'tart', 13:02:39 INFO - 'tscrollx', 13:02:39 INFO - 'cart']}, 13:02:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:39 INFO - 'tests': ['tp5o']}, 13:02:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:39 INFO - 'talos_options': ['--e10s'], 13:02:39 INFO - 'tests': ['tp5o']}, 13:02:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:39 INFO - 'talos_options': ['--xperf_path', 13:02:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:02:39 INFO - 'tests': ['tp5n']}, 13:02:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:39 INFO - 'talos_options': ['--e10s', 13:02:39 INFO - '--xperf_path', 13:02:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:02:39 INFO - 'tests': ['tp5n']}}, 13:02:39 INFO - 'talos.zip': {'path': '', 13:02:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:02:39 INFO - Running post-action listener: _resource_record_post_action 13:02:39 INFO - ##### 13:02:39 INFO - ##### Running create-virtualenv step. 13:02:39 INFO - ##### 13:02:39 INFO - Running pre-action listener: _resource_record_pre_action 13:02:39 INFO - Running main action method: create_virtualenv 13:02:39 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:02:39 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 13:02:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:02:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:02:39 INFO - Using real prefix '/usr' 13:02:39 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:02:40 INFO - Installing distribute.............................................................................................................................................................................................done. 13:02:42 INFO - Installing pip.................done. 13:02:42 INFO - Return code: 0 13:02:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:02: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')]} 13:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02: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')]} 13:02:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:42 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 0x7f263b8ddc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fae7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2d70>, '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 0x1ff3b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3fb0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1447964726.328778-1913886165', '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 13:02:42 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 13:02:42 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 13:02:42 INFO - Using env: {'DISPLAY': ':0', 13:02:42 INFO - 'HOME': '/home/cltbld', 13:02:42 INFO - 'LANG': 'en_US.UTF-8', 13:02:42 INFO - 'LANGUAGE': 'en_US:en', 13:02:42 INFO - 'LOGNAME': 'cltbld', 13:02:42 INFO - 'MAIL': '/var/mail/cltbld', 13:02:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:42 INFO - 'MOZ_NO_REMOTE': '1', 13:02:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:42 INFO - 'NO_EM_RESTART': '1', 13:02:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:02:42 INFO - 'PWD': '/builds/slave/test-pgo', 13:02:42 INFO - 'SHELL': '/bin/bash', 13:02:42 INFO - 'SHLVL': '1', 13:02:42 INFO - 'TERM': 'linux', 13:02:42 INFO - 'TMOUT': '86400', 13:02:42 INFO - 'USER': 'cltbld', 13:02:42 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1447964726.328778-1913886165', 13:02:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:42 INFO - '_': '/tools/buildbot/bin/python'} 13:02:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:42 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 13:02:42 INFO - Cleaning up... 13:02:42 INFO - Return code: 0 13:02:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:02: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')]} 13:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02: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')]} 13:02:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:42 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 0x7f263b8ddc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fae7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2d70>, '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 0x1ff3b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3fb0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1447964726.328778-1913886165', '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 13:02:42 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 13:02:42 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 13:02:42 INFO - Using env: {'DISPLAY': ':0', 13:02:42 INFO - 'HOME': '/home/cltbld', 13:02:42 INFO - 'LANG': 'en_US.UTF-8', 13:02:42 INFO - 'LANGUAGE': 'en_US:en', 13:02:42 INFO - 'LOGNAME': 'cltbld', 13:02:42 INFO - 'MAIL': '/var/mail/cltbld', 13:02:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:42 INFO - 'MOZ_NO_REMOTE': '1', 13:02:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:42 INFO - 'NO_EM_RESTART': '1', 13:02:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:02:42 INFO - 'PWD': '/builds/slave/test-pgo', 13:02:42 INFO - 'SHELL': '/bin/bash', 13:02:42 INFO - 'SHLVL': '1', 13:02:42 INFO - 'TERM': 'linux', 13:02:42 INFO - 'TMOUT': '86400', 13:02:42 INFO - 'USER': 'cltbld', 13:02:42 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1447964726.328778-1913886165', 13:02:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:42 INFO - '_': '/tools/buildbot/bin/python'} 13:02:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:42 INFO - Downloading/unpacking psutil>=0.7.1 13:02:42 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 13:02:42 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 13:02:42 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 13:02:42 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 13:02:42 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 13:02:42 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 13:02:44 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 13:02:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:02:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:02:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:02:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:02:44 INFO - Installing collected packages: psutil 13:02:44 INFO - Running setup.py install for psutil 13:02:44 INFO - building 'psutil._psutil_linux' extension 13:02:44 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 13:02:44 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 13:02:44 INFO - building 'psutil._psutil_posix' extension 13:02:44 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 13:02:45 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 13:02:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:02:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:02:45 INFO - Successfully installed psutil 13:02:45 INFO - Cleaning up... 13:02:45 INFO - Return code: 0 13:02:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:02:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f263b8ddc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fae7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2d70>, '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 0x1ff3b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3fb0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1447964726.328778-1913886165', '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 13:02:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 13:02:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:02:45 INFO - Using env: {'DISPLAY': ':0', 13:02:45 INFO - 'HOME': '/home/cltbld', 13:02:45 INFO - 'LANG': 'en_US.UTF-8', 13:02:45 INFO - 'LANGUAGE': 'en_US:en', 13:02:45 INFO - 'LOGNAME': 'cltbld', 13:02:45 INFO - 'MAIL': '/var/mail/cltbld', 13:02:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:45 INFO - 'MOZ_NO_REMOTE': '1', 13:02:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:45 INFO - 'NO_EM_RESTART': '1', 13:02:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:02:45 INFO - 'PWD': '/builds/slave/test-pgo', 13:02:45 INFO - 'SHELL': '/bin/bash', 13:02:45 INFO - 'SHLVL': '1', 13:02:45 INFO - 'TERM': 'linux', 13:02:45 INFO - 'TMOUT': '86400', 13:02:45 INFO - 'USER': 'cltbld', 13:02:45 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1447964726.328778-1913886165', 13:02:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:45 INFO - '_': '/tools/buildbot/bin/python'} 13:02:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:02:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:02:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:02:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:02:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:02:47 INFO - Installing collected packages: mozsystemmonitor 13:02:47 INFO - Running setup.py install for mozsystemmonitor 13:02:47 INFO - Successfully installed mozsystemmonitor 13:02:47 INFO - Cleaning up... 13:02:47 INFO - Return code: 0 13:02:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:02: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')]} 13:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02: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')]} 13:02:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02: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', '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 0x7f263b8ddc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fae7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2d70>, '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 0x1ff3b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3fb0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1447964726.328778-1913886165', '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 13:02: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 13:02: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 blobuploader==1.2.4 13:02:47 INFO - Using env: {'DISPLAY': ':0', 13:02:47 INFO - 'HOME': '/home/cltbld', 13:02:47 INFO - 'LANG': 'en_US.UTF-8', 13:02:47 INFO - 'LANGUAGE': 'en_US:en', 13:02:47 INFO - 'LOGNAME': 'cltbld', 13:02:47 INFO - 'MAIL': '/var/mail/cltbld', 13:02:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:47 INFO - 'MOZ_NO_REMOTE': '1', 13:02:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:47 INFO - 'NO_EM_RESTART': '1', 13:02:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:02:47 INFO - 'PWD': '/builds/slave/test-pgo', 13:02:47 INFO - 'SHELL': '/bin/bash', 13:02:47 INFO - 'SHLVL': '1', 13:02:47 INFO - 'TERM': 'linux', 13:02:47 INFO - 'TMOUT': '86400', 13:02:47 INFO - 'USER': 'cltbld', 13:02:47 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1447964726.328778-1913886165', 13:02:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:47 INFO - '_': '/tools/buildbot/bin/python'} 13:02:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:47 INFO - Downloading/unpacking blobuploader==1.2.4 13:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:49 INFO - Downloading blobuploader-1.2.4.tar.gz 13:02:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:02:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:02:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:02:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:02:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:02: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 13:02: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 13:02: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 13:02: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 13:02: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 13:02: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 13:02:50 INFO - Downloading docopt-0.6.1.tar.gz 13:02:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:02:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:02:50 INFO - Installing collected packages: blobuploader, requests, docopt 13:02:50 INFO - Running setup.py install for blobuploader 13:02:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:02:50 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:02:50 INFO - Running setup.py install for requests 13:02:50 INFO - Running setup.py install for docopt 13:02:51 INFO - Successfully installed blobuploader requests docopt 13:02:51 INFO - Cleaning up... 13:02:51 INFO - Return code: 0 13:02:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:02:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:51 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 0x7f263b8ddc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fae7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2d70>, '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 0x1ff3b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3fb0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1447964726.328778-1913886165', '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 13:02:51 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 13:02:51 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 13:02:51 INFO - Using env: {'DISPLAY': ':0', 13:02:51 INFO - 'HOME': '/home/cltbld', 13:02:51 INFO - 'LANG': 'en_US.UTF-8', 13:02:51 INFO - 'LANGUAGE': 'en_US:en', 13:02:51 INFO - 'LOGNAME': 'cltbld', 13:02:51 INFO - 'MAIL': '/var/mail/cltbld', 13:02:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:51 INFO - 'MOZ_NO_REMOTE': '1', 13:02:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:51 INFO - 'NO_EM_RESTART': '1', 13:02:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:02:51 INFO - 'PWD': '/builds/slave/test-pgo', 13:02:51 INFO - 'SHELL': '/bin/bash', 13:02:51 INFO - 'SHLVL': '1', 13:02:51 INFO - 'TERM': 'linux', 13:02:51 INFO - 'TMOUT': '86400', 13:02:51 INFO - 'USER': 'cltbld', 13:02:51 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1447964726.328778-1913886165', 13:02:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:51 INFO - '_': '/tools/buildbot/bin/python'} 13:02:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:02:51 INFO - Running setup.py (path:/tmp/pip-qFDHg7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:02:51 INFO - Running setup.py (path:/tmp/pip-Qra08G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:02:51 INFO - Running setup.py (path:/tmp/pip-cQGMgw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:02:51 INFO - Running setup.py (path:/tmp/pip-9nSb7m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:02:51 INFO - Running setup.py (path:/tmp/pip-6zgfI5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:02:51 INFO - Running setup.py (path:/tmp/pip-pJr334-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:02:51 INFO - Running setup.py (path:/tmp/pip-lCcJUf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:02:51 INFO - Running setup.py (path:/tmp/pip-9ItICg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:02:51 INFO - Running setup.py (path:/tmp/pip-bNmEzx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:02:51 INFO - Running setup.py (path:/tmp/pip-XFls5l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:02:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:02:52 INFO - Running setup.py (path:/tmp/pip-7pgMuu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:02:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:02:52 INFO - Running setup.py (path:/tmp/pip-Myo0j5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:02:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:02:52 INFO - Running setup.py (path:/tmp/pip-omFIBg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:02:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:02:52 INFO - Running setup.py (path:/tmp/pip-azW6HT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:02:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:02:52 INFO - Running setup.py (path:/tmp/pip-q32Fut-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:02:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:02:52 INFO - Running setup.py (path:/tmp/pip-q9m9Y0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:02:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:02:52 INFO - Running setup.py (path:/tmp/pip-JPOKYR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:02:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:02:52 INFO - Running setup.py install for manifestparser 13:02:52 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:02:52 INFO - Running setup.py install for mozcrash 13:02:52 INFO - Running setup.py install for mozdebug 13:02:52 INFO - Running setup.py install for mozdevice 13:02:52 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:02:52 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:02:52 INFO - Running setup.py install for mozfile 13:02:53 INFO - Running setup.py install for mozhttpd 13:02:53 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:02:53 INFO - Running setup.py install for mozinfo 13:02:53 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:02:53 INFO - Running setup.py install for mozInstall 13:02:53 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:02:53 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:02:53 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:02:53 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:02:53 INFO - Running setup.py install for mozleak 13:02:53 INFO - Running setup.py install for mozlog 13:02:53 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:02:53 INFO - Running setup.py install for moznetwork 13:02:53 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:02:53 INFO - Running setup.py install for mozprocess 13:02:53 INFO - Running setup.py install for mozprofile 13:02:53 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:02:53 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:02:53 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:02:53 INFO - Running setup.py install for mozrunner 13:02:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:02:54 INFO - Running setup.py install for mozscreenshot 13:02:54 INFO - Running setup.py install for moztest 13:02:54 INFO - Running setup.py install for mozversion 13:02:54 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:02:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:02:54 INFO - Cleaning up... 13:02:54 INFO - Return code: 0 13:02:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:02:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f263b8ddc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fae7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2d70>, '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 0x1ff3b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3fb0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1447964726.328778-1913886165', '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 13:02:54 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 13:02:54 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 13:02:54 INFO - Using env: {'DISPLAY': ':0', 13:02:54 INFO - 'HOME': '/home/cltbld', 13:02:54 INFO - 'LANG': 'en_US.UTF-8', 13:02:54 INFO - 'LANGUAGE': 'en_US:en', 13:02:54 INFO - 'LOGNAME': 'cltbld', 13:02:54 INFO - 'MAIL': '/var/mail/cltbld', 13:02:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:54 INFO - 'MOZ_NO_REMOTE': '1', 13:02:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:54 INFO - 'NO_EM_RESTART': '1', 13:02:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:02:54 INFO - 'PWD': '/builds/slave/test-pgo', 13:02:54 INFO - 'SHELL': '/bin/bash', 13:02:54 INFO - 'SHLVL': '1', 13:02:54 INFO - 'TERM': 'linux', 13:02:54 INFO - 'TMOUT': '86400', 13:02:54 INFO - 'USER': 'cltbld', 13:02:54 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1447964726.328778-1913886165', 13:02:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:54 INFO - '_': '/tools/buildbot/bin/python'} 13:02:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:02:54 INFO - Running setup.py (path:/tmp/pip-nttFOa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:02:54 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)) 13:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:02:54 INFO - Running setup.py (path:/tmp/pip-2yQ1YY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:02:54 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)) 13:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:02:54 INFO - Running setup.py (path:/tmp/pip-NtmrZy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:02:54 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)) 13:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:02:54 INFO - Running setup.py (path:/tmp/pip-RTCZj4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:02:54 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)) 13:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:02:54 INFO - Running setup.py (path:/tmp/pip-6GLbeJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:02:54 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)) 13:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:02:54 INFO - Running setup.py (path:/tmp/pip-ye5edj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:02:55 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)) 13:02:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:02:55 INFO - Running setup.py (path:/tmp/pip-yI5WEW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:02:55 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)) 13:02:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:02:55 INFO - Running setup.py (path:/tmp/pip-eVD0gR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:02:55 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)) 13:02:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:02:55 INFO - Running setup.py (path:/tmp/pip-48qaXC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:02:55 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)) 13:02:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:02:55 INFO - Running setup.py (path:/tmp/pip-QunCFT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:02:55 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)) 13:02:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:02:55 INFO - Running setup.py (path:/tmp/pip-PcdyWa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:02:55 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)) 13:02:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:02:55 INFO - Running setup.py (path:/tmp/pip-wRM8aH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:02:55 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)) 13:02:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:02:55 INFO - Running setup.py (path:/tmp/pip-TZzXg_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:02:55 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)) 13:02:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:02:55 INFO - Running setup.py (path:/tmp/pip-q42Jkf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:02:55 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)) 13:02:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:02:55 INFO - Running setup.py (path:/tmp/pip-s3uKDi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:02:55 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)) 13:02:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:02:55 INFO - Running setup.py (path:/tmp/pip-3gagLU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:02:55 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)) 13:02:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:02:55 INFO - Running setup.py (path:/tmp/pip-Ka9Hto-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:02:55 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)) 13:02:55 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)) 13:02:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:02:55 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)) 13:02:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:02:55 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)) 13:02:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:02: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 13:02: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 13:02: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 13:02: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 13:02: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 13:02: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 13:02:57 INFO - Downloading blessings-1.5.1.tar.gz 13:02:57 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 13:02:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:02:57 INFO - Installing collected packages: blessings 13:02:57 INFO - Running setup.py install for blessings 13:02:57 INFO - Successfully installed blessings 13:02:57 INFO - Cleaning up... 13:02:57 INFO - Return code: 0 13:02:57 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:02:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:02:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:02:57 INFO - Reading from file tmpfile_stdout 13:02:57 INFO - Current package versions: 13:02:57 INFO - argparse == 1.2.1 13:02:57 INFO - blessings == 1.5.1 13:02:57 INFO - blobuploader == 1.2.4 13:02:57 INFO - docopt == 0.6.1 13:02:57 INFO - manifestparser == 1.1 13:02:57 INFO - mozInstall == 1.12 13:02:57 INFO - mozcrash == 0.16 13:02:57 INFO - mozdebug == 0.1 13:02:57 INFO - mozdevice == 0.47 13:02:57 INFO - mozfile == 1.2 13:02:57 INFO - mozhttpd == 0.7 13:02:57 INFO - mozinfo == 0.9 13:02:57 INFO - mozleak == 0.1 13:02:57 INFO - mozlog == 3.0 13:02:57 INFO - moznetwork == 0.27 13:02:57 INFO - mozprocess == 0.22 13:02:57 INFO - mozprofile == 0.27 13:02:57 INFO - mozrunner == 6.11 13:02:57 INFO - mozscreenshot == 0.1 13:02:57 INFO - mozsystemmonitor == 0.0 13:02:57 INFO - moztest == 0.7 13:02:57 INFO - mozversion == 1.4 13:02:57 INFO - psutil == 3.1.1 13:02:57 INFO - requests == 1.2.3 13:02:57 INFO - wsgiref == 0.1.2 13:02:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:57 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 0x7f263b8ddc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fae7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2d70>, '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 0x1ff3b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3fb0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1447964726.328778-1913886165', '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 13:02:57 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 13:02:57 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 13:02:57 INFO - Using env: {'DISPLAY': ':0', 13:02:57 INFO - 'HOME': '/home/cltbld', 13:02:57 INFO - 'LANG': 'en_US.UTF-8', 13:02:57 INFO - 'LANGUAGE': 'en_US:en', 13:02:57 INFO - 'LOGNAME': 'cltbld', 13:02:57 INFO - 'MAIL': '/var/mail/cltbld', 13:02:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:57 INFO - 'MOZ_NO_REMOTE': '1', 13:02:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:57 INFO - 'NO_EM_RESTART': '1', 13:02:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:02:57 INFO - 'PWD': '/builds/slave/test-pgo', 13:02:57 INFO - 'SHELL': '/bin/bash', 13:02:57 INFO - 'SHLVL': '1', 13:02:57 INFO - 'TERM': 'linux', 13:02:57 INFO - 'TMOUT': '86400', 13:02:57 INFO - 'USER': 'cltbld', 13:02:57 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1447964726.328778-1913886165', 13:02:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:57 INFO - '_': '/tools/buildbot/bin/python'} 13:02:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:58 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)) 13:02:58 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)) 13:02:58 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)) 13:02:58 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)) 13:02:58 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)) 13:02:58 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)) 13:02:58 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)) 13:02:58 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)) 13:02:58 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)) 13:02:58 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)) 13:02:58 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)) 13:02:58 INFO - Cleaning up... 13:02:58 INFO - Return code: 0 13:02:58 INFO - Running post-action listener: _resource_record_post_action 13:02:58 INFO - Running post-action listener: _start_resource_monitoring 13:02:58 INFO - Starting resource monitoring. 13:02:58 INFO - ##### 13:02:58 INFO - ##### Running install step. 13:02:58 INFO - ##### 13:02:58 INFO - Running pre-action listener: _resource_record_pre_action 13:02:58 INFO - Running main action method: install 13:02:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:02:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:02:58 INFO - Reading from file tmpfile_stdout 13:02:58 INFO - Detecting whether we're running mozinstall >=1.0... 13:02:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:02:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:02:58 INFO - Reading from file tmpfile_stdout 13:02:58 INFO - Output received: 13:02:58 INFO - Usage: mozinstall [options] installer 13:02:58 INFO - Options: 13:02:58 INFO - -h, --help show this help message and exit 13:02:58 INFO - -d DEST, --destination=DEST 13:02:58 INFO - Directory to install application into. [default: 13:02:58 INFO - "/builds/slave/test-pgo"] 13:02:58 INFO - --app=APP Application being installed. [default: firefox] 13:02:58 INFO - mkdir: /builds/slave/test-pgo/build/application 13:02:58 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'] 13:02:58 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 13:03:12 INFO - Reading from file tmpfile_stdout 13:03:12 INFO - Output received: 13:03:12 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:03:12 INFO - Running post-action listener: _resource_record_post_action 13:03:12 INFO - ##### 13:03:12 INFO - ##### Running run-tests step. 13:03:12 INFO - ##### 13:03:12 INFO - Running pre-action listener: _resource_record_pre_action 13:03:12 INFO - Running main action method: run_tests 13:03:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:03:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:03:12 INFO - Python 2.7.3 13:03:12 INFO - Return code: 0 13:03:12 INFO - grabbing minidump binary from tooltool 13:03:12 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')]} 13:03:12 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 0x1ff2d70>, '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 0x1ff3b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:03:12 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 13:03:12 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 13:03:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:03:12 INFO - Return code: 0 13:03:12 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:03:12 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:03:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:03:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:03:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:03:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 13:03:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost 13:03:12 INFO - Using env: {'DISPLAY': ':0', 13:03:12 INFO - 'HOME': '/home/cltbld', 13:03:12 INFO - 'LANG': 'en_US.UTF-8', 13:03:12 INFO - 'LANGUAGE': 'en_US:en', 13:03:12 INFO - 'LOGNAME': 'cltbld', 13:03:12 INFO - 'MAIL': '/var/mail/cltbld', 13:03:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:03:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:12 INFO - 'MOZ_NO_REMOTE': '1', 13:03:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:03:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:12 INFO - 'NO_EM_RESTART': '1', 13:03:12 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:03:12 INFO - 'PWD': '/builds/slave/test-pgo', 13:03:12 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:03:12 INFO - 'SHELL': '/bin/bash', 13:03:12 INFO - 'SHLVL': '1', 13:03:12 INFO - 'TERM': 'linux', 13:03:12 INFO - 'TMOUT': '86400', 13:03:12 INFO - 'USER': 'cltbld', 13:03:12 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1447964726.328778-1913886165', 13:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:12 INFO - '_': '/tools/buildbot/bin/python'} 13:03:12 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost'] with output_timeout 3600 13:03:13 INFO - mozversion INFO | application_buildid: 20151119113006 13:03:13 INFO - mozversion INFO | application_changeset: 5732e276c41ce1e771d4d550e8a95afdd9a2b105 13:03:13 INFO - mozversion INFO | application_display_name: Nightly 13:03:13 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:03:13 INFO - mozversion INFO | application_name: Firefox 13:03:13 INFO - mozversion INFO | application_remotingname: firefox 13:03:13 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 13:03:13 INFO - mozversion INFO | application_vendor: Mozilla 13:03:13 INFO - mozversion INFO | application_version: 45.0a1 13:03:13 INFO - mozversion INFO | platform_buildid: 20151119113006 13:03:13 INFO - mozversion INFO | platform_changeset: 5732e276c41ce1e771d4d550e8a95afdd9a2b105 13:03:13 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 13:03:13 INFO - mozversion INFO | platform_version: 45.0a1 13:03:13 INFO - 2015-11-19 13:03:13,122 DEBUG : using testdate: 1447966993 13:03:13 INFO - 2015-11-19 13:03:13,122 DEBUG : actual date: 1447966993 13:03:13 INFO - 2015-11-19 13:03:13,131 INFO : starting webserver on 'localhost:50313' 13:03:13 INFO - 2015-11-19 13:03:13,132 INFO : Starting test suite talos-linux64-ix-054 13:03:13 INFO - 2015-11-19 13:03:13,132 INFO : Starting test dromaeo_css 13:03:13 INFO - 2015-11-19 13:03:13,132 DEBUG : operating with platform_type : linux_ 13:03:13 INFO - 2015-11-19 13:03:13,133 INFO : Initialising browser for dromaeo_css test... 13:03:13 INFO - 2015-11-19 13:03:13,149 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9XuBIU/profile http://localhost:50313/getInfo.html 13:03:17 INFO - 2015-11-19 13:03:17,420 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:03:17 INFO - 2015-11-19 13:03:17,421 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:03:17 INFO - 2015-11-19 13:03:17,421 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:03:17 INFO - 2015-11-19 13:03:17,421 DEBUG : BROWSER_OUTPUT: __metrics 13:03:17 INFO - 2015-11-19 13:03:17,558 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:03:19 INFO - 2015-11-19 13:03:19,019 INFO : Browser initialized. 13:03:19 INFO - 2015-11-19 13:03:19,020 INFO : Running cycle 1/1 for dromaeo_css test... 13:03:19 INFO - 2015-11-19 13:03:19,020 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9XuBIU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:03:30 INFO - 2015-11-19 13:03:30,791 DEBUG : BROWSER_OUTPUT: RSS: Main: 141594624 13:03:30 INFO - 2015-11-19 13:03:30,791 DEBUG : BROWSER_OUTPUT: 13:04:21 INFO - 2015-11-19 13:04:21,468 DEBUG : BROWSER_OUTPUT: 1447967061467 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] 13:06:31 INFO - 2015-11-19 13:06:31,410 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50313/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50313/tests/dromaeo/cssquery-ext.html) 13:06:32 INFO - 2015-11-19 13:06:32,716 DEBUG : BROWSER_OUTPUT: RSS: Main: 269668352 13:06:32 INFO - 2015-11-19 13:06:32,717 DEBUG : BROWSER_OUTPUT: 13:09:35 INFO - 2015-11-19 13:09:35,074 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50313/tests/dromaeo/cssquery-ext.html (next: http://localhost:50313/tests/dromaeo/cssquery-jquery.html) 13:09:35 INFO - 2015-11-19 13:09:35,639 DEBUG : BROWSER_OUTPUT: RSS: Main: 224927744 13:09:35 INFO - 2015-11-19 13:09:35,639 DEBUG : BROWSER_OUTPUT: 13:12:37 INFO - 2015-11-19 13:12:37,611 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50313/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50313/tests/dromaeo/cssquery-mootools.html) 13:12:38 INFO - 2015-11-19 13:12:38,176 DEBUG : BROWSER_OUTPUT: RSS: Main: 221429760 13:12:38 INFO - 2015-11-19 13:12:38,177 DEBUG : BROWSER_OUTPUT: 13:15:40 INFO - 2015-11-19 13:15:40,091 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50313/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50313/tests/dromaeo/cssquery-prototype.html) 13:15:40 INFO - 2015-11-19 13:15:40,652 DEBUG : BROWSER_OUTPUT: RSS: Main: 201777152 13:15:40 INFO - 2015-11-19 13:15:40,652 DEBUG : BROWSER_OUTPUT: 13:18:43 INFO - 2015-11-19 13:18:43,117 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50313/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50313/tests/dromaeo/cssquery-yui.html) 13:18:43 INFO - 2015-11-19 13:18:43,683 DEBUG : BROWSER_OUTPUT: RSS: Main: 201375744 13:18:43 INFO - 2015-11-19 13:18:43,683 DEBUG : BROWSER_OUTPUT: 13:21:46 INFO - 2015-11-19 13:21:46,073 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50313/tests/dromaeo/cssquery-yui.html (next: http://localhost:50313/tests/dromaeo/cssquery-dojo.html) 13:21:46 INFO - 2015-11-19 13:21:46,332 DEBUG : BROWSER_OUTPUT: RSS: Main: 263282688 13:21:46 INFO - 2015-11-19 13:21:46,332 DEBUG : BROWSER_OUTPUT: 13:21:46 INFO - 2015-11-19 13:21:46,332 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:21:46 INFO - 2015-11-19 13:21:46,332 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:21:46 INFO - 2015-11-19 13:21:46,332 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:21:46 INFO - 2015-11-19 13:21:46,332 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:21:46 INFO - 2015-11-19 13:21:46,332 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3217.2921957169424;3267.0688853676706;3310.966890331096;3317.2536179359645;3336.132605522564;5301.231321458386;5363;5390.8921821563545;5398.352197736267;5411.053065713504;5407.729613519318;5433;5462.535684466825;5481.780728770845;5525.281713377265;4979.228219625964;5000.074986127578;5016.3227964224725;5024.171011783052;5102.897942041157;4887.682300650464;5039.521245481674;5116.744162791864;5128.282040514331;5190.091733946563;4982.551570358649;5030.0694371541385;5075.6447048706605;5086.033653605803;5087.898242035176;5031.798728050873;5050.747462626854;5057.645964782467;5063.417706963673;5122.1036318644465;4919.458859525449;5020.723860187724;5026.195808670595;5031.547160755513;5036.471170527115;5234.345706786652;5249.895002099975;5343.625946183769;5360.410354860962;5379.273798037254;5978.163057172;5987.850303742398;5989.431004054652;5989.940100599026;6004.309504407005;5836.9124463133085;6018.879622407571;6022.8494287642725;6028.246469191351;6033.276006879159;5473.480019398191;5526.944730552724;5531.1426728857095;5535.916961245544;5578;6053.092036194518;6073.331933487313;6081.817545473643;6086.300075491286;6101.5118790497545;5673.801416950387;5900.586958912835;5909.586328957018;5910.320313164041;5913.113033044991;5835.79574714883;5859.853503662357;5862.208601838697;5897.646141231454;5949.494292985145;5853.502452291603;5909.734061967221;5912.645241285537;5913.438223368773;5913.704314784243;5675.2054712340305;5794.565407594448;5896.7641294348605;5906.970465147647;5916.083007133815;4488.775561221991;4530.682852200381;4533.478649955231;4571.22289210835;4574.977125114353;4060.0661847775177;4072.165206132736;4086.3053280942313;4086.8773936781945;4106.281400754856;5422.457754224546;5525.088360420566;5648.915266271009;5652.604317697804;5655.4910058094965;5882.235309409835;5915.792947246911;5957.046872500379;5976.7908123215475;5987.790427335022;5636.126400407943;5652.547796176296;5652.943470565242;5655.208270842086;5659.434056594308;4988.625853061035;5060.418051924076;5129.9230511542355;5185.274061631375;5204.635675502678;6001.399860013964;6119.816405507753;6120.540959427972;6129.448349648464;6130.049842274455;5942.61373010753;5980.8803823924145;5982.7307771149535;5987.790427335022;5991.670458124845;5964.731587078679;6074.848128796639;6075.2405949256345;6165.722542485689;6168.414000669929;5790.768369265183;5859.560532959959;5859.824205273849;5874.853128671646;5925.585209035326;5924.31870334917;5961.135635332939;5966.627675634541;5973.283206015306;5976.432238937294;5478.397376288525;5669.518090962314;5697.23087383198;5827.970860145672;5831.1544826000845;5846.444587764156;5847.210626565529;5849.327327357409;5850.0932355484965;5894.145348924468;5756.395578464201;5757.222774925332;5757.769689212385;5760.395158508464;5762.94237057624;5697.800576979786;5726.74229659658;5773.942260577341;5820.126980952721;5857.033589457692;5706.343770466449;5739.770409183586;5746.9712651436475;5754.5684073695475;5808.5062769665055 13:21:46 INFO - 2015-11-19 13:21:46,332 DEBUG : BROWSER_OUTPUT: |1;ext.html;546.5809513620758;575.625843201919;583.3000399520577;591.5356445190525;592.7984485275006;39786.40320395193;40797.38803917944;40818.7959060205;40898.182036359256;40906.795466022704;44486.33270500937;45390.09219815602;45414;45452.3182152268;45456.318155227695;7683.078030636303;7789.610519474032;8763.211310982026;8940.374173807804;10126;10362.585496580128;10470.319429237075;10470.738231544196;10488.737781555485;10491;10486.632967846126;10563.524641391117;10568.947155264252;10572.577096916115;10592.841107383396;7936.5238085714755;8104.351651867866;10660.307080039773;10880.401577913211;10924.344539327665;10344.293191623374;10474.214433917487;10475.371477711362;10480.895191048068;10487.003734645197;40741;41048.38427423591;41165.176696465904;41231.58768412308;41256.38115428241;3366.293078453528;3373.3421982713135;3387.830608469567;3405.897823065312;3434.210131669705;29827;30395.69604303951;30751.538726919112;31166;31573.21066973321;3521.9823900880333;3559.982200088983;3612.223371975038;3663.835127419246;3670.972127804219;270819;271497;271775;271902.999999998;272022;58081.419185808445;59342.40657593369;59657;60045.699771501735;60171;68921;69958.3004169962;70247.29752702407;70272;70405.64797175981;16167.272472738756;16382.180890955642;16429.424970125987;16442.177891105635;16448.342066317215;11502.827457588142;11557.364344960939;11559.711007224718;11620;11625.24435911663;19553;19758.11088501021;19803.306884258982;19811.10850011753;19830.305939292055;7500.587467689329;7520;7597.658105385271;7645.5794931279315;7668.9616551918;907.1654078248027;910.8497097978892;982.1308142293979;986.7335819328741;1072.9946350268356;28705.861309988093;29012.27469313284;29019.70980290212;29470.115896523137;29726.554101688493;1020.3010937507831;1031.504877658728;1037.486444210121;1056.4717641179411;1059.1050562274866;13927.303634818421;14288.928555357157;14294.85705142956;15237.466688665843;15623.531294061197;319957;327122;327411;327580;327741;54533.45466545363;54688;55083.72458137684;55128;55222.723886381114;1379.9507731019428;1384.1694983010314;1392.3316807932047;1400.9089409188573;1410.8448070712213;28282.2929426766;28652.71347286584;29024.564631530968;29250.707492924797;29311.7068829309;42977;44526.3321050191;46287.537124628325;46774;46972.7651361741;300032;306539;306631;308868;309205;28653;28798.136055918356;29154.562681559368;29465.263368415963;29543.409131817672;39041.60958390493;39954;39963.40054899237;40329.1934161321;40440.59559404368;33437.498437523944;33627.49558756572;34050;36015.27969440649;37291.81354093212;33151.63231952769;33486.66513334835;34124.31751364909;34339.4849077269;34517.137071572404;33400.33199336048;33721;33814.49278260779;34218.82890585531;34218.973430797116;30472;30606;31245.375092498478;31487.84256078705;31488.527672084478;23203.883980580664;24227.51544969126;24963.500729985662;25070.247892563253;25169.49661006806 13:21:46 INFO - 2015-11-19 13:21:46,332 DEBUG : BROWSER_OUTPUT: |2;jquery.html;357.66445113409446;359.35854499718;359.46619270383474;360.86647940262105;362.82040390006915;14453.349599268033;14757.40970361187;16838.747418788713;17273.481795546137;17958.999999999985;12080.214786038901;12345;16553.337866485355;17073.060981646006;17076.829231707678;4569.497355290915;4670.76646167692;4671.439427268716;4675.2052151134385;4686.226772582537;3555.5911070226866;3647.106458917569;4618.445786505607;5048.1165795985735;5141.562967147797;5014.548690617844;5050.898982020376;5070.797168113271;5082.51716086973;5108.208227724708;4744.312074749142;4744.762761861911;4773.188557945157;4886.609071274307;5086.186210206368;4374.190774706658;4444.488883778375;4445.822167113344;4455.086707225011;4456.955430445686;14019.719605607932;14087.577372678836;14359.569212923629;14535.345909433996;14537.927310363486;1980.1386396917244;2006.6388050150968;2034.5829105033433;2102.8633138845926;2228.6545585434283;10158.746031349201;10277.31893424092;10303.27877048607;10334.844977325347;10453.47732613374;1659.9585010374717;1675.8072821625547;1687.1648533975638;1706.4198172621245;1743.59897223638;62699.37300627027;62767.37232627661;63559.68220158916;63679.68160159216;64690.67654661743;7010.474214433836;7101.076860008269;7142.750003749844;7182.676779544933;7199.784006479814;8594.441361311494;8603.741887743377;8605.526696031653;8606.956965215133;8611.913880861237;5739.624582411664;5753.510951569164;5755.1079582663915;5785.50823180026;5792.073268277056;5872.29532456108;5913.970430147821;5927.911081333784;5938.168656388109;6046.09308603713;3290.144562413742;3293.8023718576483;3333.8999830005137;3340.732741380684;3360.899173024813;1131.4455916600807;1155.7746239483388;1175.5415387998687;1179.5517703272874;1220.8718084601167;469.2210929856422;472.0723777776617;473.5477618873967;474.23174457379264;519.5246349590158;11762.294262344287;11820.527178912747;11868.258362855006;11907.940460297643;12350.3824808761;460.10509558907603;495.9851204463872;510.72165669710097;523.0663266070122;539.5198273536556;6482.967585162044;6853;6875.106236189264;6917.412019978358;7087.716491340392;538500;544658;555152;560061;563711;77738.6113069431;81036.59481702554;83453;84131;84426;553.485258709396;561.1190431023255;565.3018522125254;566.1620801214144;566.8412844403574;10914.563417463212;11180.608678696206;11446.484908179318;11452.198346116025;11611.303321800719;33460;34794.65205348015;35903.28193436169;37070.44394334033;38349.041273968374;48779.51220487892;49075.50924490852;50006.74996624994;50314.28386576725;50885;7008.053912721717;7065.258147894603;7117.252688467636;7121.893171602534;7136.857262854817;12054.819177712166;12644.810327845275;12669.113162078935;12916.354182291036;12920.289384083966;10875.728106797393;11066.944665276622;11207;11262.605808796652;11357.602483913024;10860.945695271474;10998.615048473264;11049.668509944715;11082.722931926444;11115.555377784798;8160.30637395828;9691.612335506501;11420.885791141982;11525.193236473366;11582.189246752647;6830.077939478107;6886.965565172342;6899.689513971783;7024.964875175591;7036.683349249193;10789.676309710721;10867.728306792393;10889.346639201673;11028.062614677843;11253.437328133397 13:21:46 INFO - 2015-11-19 13:21:46,332 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1391.1027387335175;1756.464278395089;1767.9558011049721;1769.4780039888233;1804.0221312007027;6784.830379240521;7738.0714314282295;7875.566843823587;7892.881606775903;7899.565523896198;7582.84834303315;7708.152103268636;7709.807254818632;7714.768556943287;7718.536887786723;2030.0560239488634;2069.1206237349143;2071.3785864240745;2288.4507718147693;2308.572914010905;2332.93001209964;2390.3546042568496;2394.7485514021037;2395.3652282145244;2397.1010870923405;2235.642297232443;2265.2184996176375;2275.4766403727153;2277.1802151225547;2279.3959600705825;1983.8313743331835;2039.9388018359473;2274.033535747309;2290.816734661223;2345.7654234576576;2290.6334986402094;2312.664663623782;2319.9420014499606;2322.431004403915;2324.628059510487;7754.3796496280165;7868.409869259771;7872.291493765589;7882.724104656367;7883.408744344139;4813.253945638432;4860.270959356089;4877.926831097537;4902.142125128088;4904.0191961607825;3184.1402821238366;3201.471757160066;3250.1874531367157;3253.869845206189;3286.9342613147605;1026.5277972132753;1046.8900765419598;1067.3062509368895;1077.95688172473;1124.7188202949262;10667.466626668713;10676;10682.78634427307;10686.038256556869;10688.78622427555;4461.643068554507;4489.932651010237;4587.151376995266;4621.653375996813;4643.558861908114;8812.911870881337;8828.293736501064;8885.777855553662;8887.15572020657;8891.244244239182;4850.684705494132;4864.294677271776;4873.342098816614;4900.313956046157;4914.508549145057;4377.9124417511475;4420.734755914656;4449.955500444954;4475.776211189427;4476.283794592915;3604.98197509016;3623.202895363069;3631.4371272452286;3650.0874781304674;3655.3603119453987;1131.4964840645998;1135.9091272698165;1150.3385553306882;1163.3543383422113;1164.3246916788241;915.455304094063;970.4953424219508;1068.930519516229;1088.711491454765;1091.0126335666234;6705.2624211336715;6821.2155602106395;6825.1127353443735;6826.761063362758;7441.702331906663;671.2817285504561;675.2740803636111;676.5940435738518;707.734599525178;719.8452332748379;5860.179574859523;5914;5914.497267732205;5918.082697181943;5921.881562368729;9081.54592270397;9099.636014559343;9298.070192980784;9344.95327523358;9373.48445835472;9453.716388508356;9487.098725621056;9516.619335226513;9536.2371010319;9555.952220238993;7226.494145409876;7265.782026539212;7312.890306645299;7318.121825380988;7372.852542949111;7369.078865141857;7471.103467583925;7474.065741782278;7477.140128885248;7477.177510473953;8102.4328297021;8246.752597422086;8247.422680412314;8393.916060839314;8457.40798144124;8501.064882862756;8563.914360856312;8725.345599079967;8731.995820480726;8741;6889.965550172217;7138.607376594337;7139.821504462222;7142.714291428492;7144.3570078693165;7580.317771400601;7687;7690.230976902265;7727.072751269883;7740.8451830964195;7029.683664235224;7084.149902011792;7196;7204.387627051759;7244.746433874789;7027.15674119109;7049.048378469046;7122.323379278961;7133.857322853618;7210.098737657793;6336.936630633819;6456.386643268882;7094.432445404458;7137.179224389261;7166.964165179141;6433.613983161025;6582.0785090086465;6672.132622759011;6679.56582822115;6684.8997265042035;6609.504287178384;6632.602043877383;6689.632070236184;6715.3620406061345;6715.966420168063 13:21:46 INFO - 2015-11-19 13:21:46,334 DEBUG : BROWSER_OUTPUT: |4;prototype.html;338.1596732120681;342.1975467528645;342.3119529745213;344.3491800497061;345.28181382723926;6076.3316035236085;6146.600470969383;6150.477209437192;6150.7539698412065;6156.045812899008;5782.566307526942;5912.940870591293;5969.731362088705;6021.8193454196335;6028.42729940656;4690.765461726917;4721.645876559254;4729.172394830891;4731.243001119821;4744.501827308126;4718.363020992174;4721.197396442596;4728.834490792823;4730.645201609876;4731.550502702255;4461.442319710036;4547.317902314663;4550.544945505456;4552.408186935694;4554.225781617133;4660.091282199973;4660.114578230159;4664.580187783115;4674.182018146845;4674.252119660872;4110.34234522475;4114.033202197481;4114.341705327133;4115.73247738899;4134.3178375567995;5764.365919748824;5767.279090113736;5770.913436298459;5770.9422905770825;5771.884562308773;5302.2311764793885;5405.243265942771;5407.080796264644;5409.6213265071465;5409.83770486886;6445;6468.8059358219325;6473.255575608819;6474.320196379406;6483.546151769378;4431.645468362523;4434.512203657595;4436.378906953029;4437.112577484484;4451.243288640939;6591.307912669196;6660.733570657168;6744.898826517606;6746.763863264811;6758.763443279461;4534.070515544306;4541.5231400703115;4547.727136371828;4551.635869130461;4553.2942393929;4595.908081838412;4599.954000460019;4600.907981840344;4605.355250264965;4607.447106347193;5333.359996800409;5345.251664766935;5361.008213480519;5362.544183744425;5371.731413429313;6309.652969086745;6460.741570337228;6466.385693359123;6473.190851143607;6561.179852518435;1628.8778341624425;1648.5054483654856;1649.5051484554585;1650.8101568319557;1651.901485512145;1086.440483151178;1087.152021423291;1087.4127970895786;1100.2023532938715;1107.5293000474926;6314.810555683245;6319.115323854664;6322.747090116344;6325.462335701517;6327.683615819191;6727;6736.360045795642;6741.157355330583;6746.595204287759;6747.122874026345;6107.969460152671;6211.2857021443115;6290.968545157245;6361.363863613602;6369.554131210771;3645.4167333226555;3648.726345524043;3669.5963444021136;3673.8530458781884;3678.356287649704;7032.92967070333;7040.295970402919;7041.8239544010785;7046.577205367695;7049.964750176319;6743;6904.1024666794;6917.792466226021;7001.124859392576;7009.824754381181;7056.576605403589;7077.186123595749;7078.079849619517;7080.610566418896;7090.042844215965;6580.374864387875;6768.221654509597;6821.522493425611;6831.760888368884;6834.419074378733;6725.562838415487;6731.225909020525;6742.359475849787;6752.966235168989;6756.729730810909;7063.364297213276;7065;7065.505414620927;7066.187388450394;7071.080759501232;4509.07563949383;4572.993941332901;4604.148232576984;4605.355250265033;4609.907801844011;6765.492588055817;6777.322267773183;6783.152105986752;6785.219699734594;6785.728570857308;6598.274189839018;6600.405963463311;6604.075429439787;6605.339466053356;6616.073749675145;6452.709628066842;6583.80248592543;6597.637129957899;6602.075709400784;6603.504737144829;6472.546921715435;6479.028145778171;6479.254885688018;6483.384078512534;6485.059666348258;6631.3700198481065;6639.203295604559;6642.2361428434415;6642.4686025118845;6646.501512386493;6337.04944258365;6438.806835794933;6458.7093580789915;6469.353064693493;6472.320406357265 13:21:46 INFO - 2015-11-19 13:21:46,335 DEBUG : BROWSER_OUTPUT: |5;yui.html;859.9828003439932;862.2713806833232;868.9782755431115;880.4145243413128;889.6797153024914;14158.575242742721;14465.783013254782;14481.855181448182;14489.058211216277;14489.710205795878;13423.932880335584;13640.113392629471;13654.112482688643;13677.384517696702;13680.384382702778;840.9831803363929;848.1476116502906;848.9897022543184;850.4939560961249;851.5912362066211;694.8957656351563;704.6089420371692;835.9623816928222;840.9915900841005;842.0779246724826;875.1030194051085;886.1935638568904;887.5562218890555;887.6937456577502;891.335954713736;878.7188099808096;882.4087861132992;885.3935054487632;885.7519894429538;885.7696998780332;531.2191079113696;534.9144136938071;637.4581605635173;649.9967500162469;650.3496503496503;13021.479140834355;13103.60689179326;13147.0797044206;13221;13234.536791212262;12317.753644927052;13049.564547899723;13151.342432878413;13291.734165316737;13298.601041968659;10277.229207809369;10396.376217426978;10629.149668026539;10875.184361172865;10889.782204355948;3272;3289.6381398046196;3298.191942973987;3393.7624366294367;3404.285100128976;45860.31209531859;46265.30602040972;46621.766891165666;46722.299165512544;47292.7635361821;7596.278353556403;7616.35261002821;7700;7706.344960678293;7771.844563108706;12908.677283067811;12920;12927.224366538037;13052.477900884049;13064.020198485152;6824.624645644537;6856.348646878539;6861.176658800876;7006.894896576556;7099.432045436352;4314.784260787011;4426.867193984185;4440.878007934734;4518.073794872043;4518.887027824265;2771.390294135287;2799.9440011199663;2806.1581525542256;2818.4363127374195;2821.195959151673;441.216840108803;450.1290003842575;455.27156549521163;461.06634066016585;464.84195373573147;679.7960611816534;682.689376333767;698.8427603789107;701.9613921234279;724.055108083945;8718.346124040723;8753.343499237582;8778;8819.206271435602;8989.910100899038;627.2128478759128;640.3468462168562;671.2012704881175;691.640347019547;708.9432845372461;4042.636162745367;4135.255653982252;4161.667066634662;4162.875113746592;4261.786910654455;60601.09098363528;62038.689806550676;62054;62078.68960655258;62091;52496;52640;53010.73494632502;53179;53636.46363536315;48511.5148848507;48608;48979.75510122427;49124.75437622861;49587;8119.596505968419;8308.70919517814;8319.334453243848;8432.45189062709;8452.36607254446;36870.07824804401;37156.814215928745;37192.814035929645;37582.8120859394;37753.24493510169;43272.350914735674;47272.52727472681;47656.285155722;48193.518064818905;48304.516954830004;7388.963055184905;7445.7766267012075;7640.083190017233;7712.8457430852195;7965.761027169194;11223.15826313046;11292.209545331747;11375.146863985068;11469.31184128955;11962.521499139937;10546.314489558154;10580;10716.089132423831;10873.836892446778;11035.710201991413;10300.124489418484;10392.376457412278;10611.628592999208;10756.300840445347;11087.501062452047;10268.897311026794;10695.465226738477;10702.89297107019;10787.568497260021;10894.727631808952;9034.367594268339;9242.953785231031;9251.121143491358;9492.715218543455;9523.857142142735;8586.64808084826;8686.261667758312;8862;9342.517592955746;9345.48599827016 13:21:46 INFO - 2015-11-19 13:21:46,335 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:21:46 INFO - 2015-11-19 13:21:46,335 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:21:46 INFO - 2015-11-19 13:21:46,335 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1058 13:21:46 INFO - 2015-11-19 13:21:46,335 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:21:46 INFO - 2015-11-19 13:21:46,335 DEBUG : BROWSER_OUTPUT: __startTimestamp1447968106324__endTimestamp 13:21:46 INFO - 2015-11-19 13:21:46,335 DEBUG : BROWSER_OUTPUT: 13:21:46 INFO - 2015-11-19 13:21:46,335 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:21:46 INFO - 2015-11-19 13:21:46,336 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:21:46 INFO - 2015-11-19 13:21:46,336 DEBUG : BROWSER_OUTPUT: 13:21:46 INFO - 2015-11-19 13:21:46,337 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5499.16 Median:5726.74 stddev:615.02 (10.7%) stddev-sans-first:590.28 13:21:46 INFO - 2015-11-19 13:21:46,337 DEBUG : BROWSER_OUTPUT: Values: 3217.3 3267.1 3311.0 3317.3 3336.1 5301.2 5363.0 5390.9 5398.4 5411.1 5407.7 5433.0 5462.5 5481.8 5525.3 4979.2 5000.1 5016.3 5024.2 5102.9 4887.7 5039.5 5116.7 5128.3 5190.1 4982.6 5030.1 5075.6 5086.0 5087.9 5031.8 5050.7 5057.6 5063.4 5122.1 4919.5 5020.7 5026.2 5031.5 5036.5 5234.3 5249.9 5343.6 5360.4 5379.3 5978.2 5987.9 5989.4 5989.9 6004.3 5836.9 6018.9 6022.8 6028.2 6033.3 5473.5 5526.9 5531.1 5535.9 5578.0 6053.1 6073.3 6081.8 6086.3 6101.5 5673.8 5900.6 5909.6 5910.3 5913.1 5835.8 5859.9 5862.2 5897.6 5949.5 5853.5 5909.7 5912.6 5913.4 5913.7 5675.2 5794.6 5896.8 5907.0 5916.1 4488.8 4530.7 4533.5 4571.2 4575.0 4060.1 4072.2 4086.3 4086.9 4106.3 5422.5 5525.1 5648.9 5652.6 5655.5 5882.2 5915.8 5957.0 5976.8 5987.8 5636.1 5652.5 5652.9 5655.2 5659.4 4988.6 5060.4 5129.9 5185.3 5204.6 6001.4 6119.8 6120.5 6129.4 6130.0 5942.6 5980.9 5982.7 5987.8 5991.7 5964.7 6074.8 6075.2 6165.7 6168.4 5790.8 5859.6 5859.8 5874.9 5925.6 5924.3 5961.1 5966.6 5973.3 5976.4 5478.4 5669.5 5697.2 5828.0 5831.2 5846.4 5847.2 5849.3 5850.1 5894.1 5756.4 5757.2 5757.8 5760.4 5762.9 5697.8 5726.7 5773.9 5820.1 5857.0 5706.3 5739.8 5747.0 5754.6 5808.5 13:21:46 INFO - 2015-11-19 13:21:46,337 DEBUG : BROWSER_OUTPUT: 13:21:46 INFO - 2015-11-19 13:21:46,337 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47433.12 Median:323539.50 stddev:79013.20 (24.4%) stddev-sans-first:79156.42 13:21:46 INFO - 2015-11-19 13:21:46,338 DEBUG : BROWSER_OUTPUT: Values: 546.6 575.6 583.3 591.5 592.8 39786.4 40797.4 40818.8 40898.2 40906.8 44486.3 45390.1 45414.0 45452.3 45456.3 7683.1 7789.6 8763.2 8940.4 10126.0 10362.6 10470.3 10470.7 10488.7 10491.0 10486.6 10563.5 10568.9 10572.6 10592.8 7936.5 8104.4 10660.3 10880.4 10924.3 10344.3 10474.2 10475.4 10480.9 10487.0 40741.0 41048.4 41165.2 41231.6 41256.4 3366.3 3373.3 3387.8 3405.9 3434.2 29827.0 30395.7 30751.5 31166.0 31573.2 3522.0 3560.0 3612.2 3663.8 3671.0 270819.0 271497.0 271775.0 271903.0 272022.0 58081.4 59342.4 59657.0 60045.7 60171.0 68921.0 69958.3 70247.3 70272.0 70405.6 16167.3 16382.2 16429.4 16442.2 16448.3 11502.8 11557.4 11559.7 11620.0 11625.2 19553.0 19758.1 19803.3 19811.1 19830.3 7500.6 7520.0 7597.7 7645.6 7669.0 907.2 910.8 982.1 986.7 1073.0 28705.9 29012.3 29019.7 29470.1 29726.6 1020.3 1031.5 1037.5 1056.5 1059.1 13927.3 14288.9 14294.9 15237.5 15623.5 319957.0 327122.0 327411.0 327580.0 327741.0 54533.5 54688.0 55083.7 55128.0 55222.7 1380.0 1384.2 1392.3 1400.9 1410.8 28282.3 28652.7 29024.6 29250.7 29311.7 42977.0 44526.3 46287.5 46774.0 46972.8 300032.0 306539.0 306631.0 308868.0 309205.0 28653.0 28798.1 29154.6 29465.3 29543.4 39041.6 39954.0 39963.4 40329.2 40440.6 33437.5 33627.5 34050.0 36015.3 37291.8 33151.6 33486.7 34124.3 34339.5 34517.1 33400.3 33721.0 33814.5 34218.8 34219.0 30472.0 30606.0 31245.4 31487.8 31488.5 23203.9 24227.5 24963.5 25070.2 25169.5 13:21:46 INFO - 2015-11-19 13:21:46,338 DEBUG : BROWSER_OUTPUT: 13:21:46 INFO - 2015-11-19 13:21:46,338 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27807.76 Median:2514.80 stddev:90646.78 (3604.5%) stddev-sans-first:90877.64 13:21:46 INFO - 2015-11-19 13:21:46,338 DEBUG : BROWSER_OUTPUT: Values: 357.7 359.4 359.5 360.9 362.8 14453.3 14757.4 16838.7 17273.5 17959.0 12080.2 12345.0 16553.3 17073.1 17076.8 4569.5 4670.8 4671.4 4675.2 4686.2 3555.6 3647.1 4618.4 5048.1 5141.6 5014.5 5050.9 5070.8 5082.5 5108.2 4744.3 4744.8 4773.2 4886.6 5086.2 4374.2 4444.5 4445.8 4455.1 4457.0 14019.7 14087.6 14359.6 14535.3 14537.9 1980.1 2006.6 2034.6 2102.9 2228.7 10158.7 10277.3 10303.3 10334.8 10453.5 1660.0 1675.8 1687.2 1706.4 1743.6 62699.4 62767.4 63559.7 63679.7 64690.7 7010.5 7101.1 7142.8 7182.7 7199.8 8594.4 8603.7 8605.5 8607.0 8611.9 5739.6 5753.5 5755.1 5785.5 5792.1 5872.3 5914.0 5927.9 5938.2 6046.1 3290.1 3293.8 3333.9 3340.7 3360.9 1131.4 1155.8 1175.5 1179.6 1220.9 469.2 472.1 473.5 474.2 519.5 11762.3 11820.5 11868.3 11907.9 12350.4 460.1 496.0 510.7 523.1 539.5 6483.0 6853.0 6875.1 6917.4 7087.7 538500.0 544658.0 555152.0 560061.0 563711.0 77738.6 81036.6 83453.0 84131.0 84426.0 553.5 561.1 565.3 566.2 566.8 10914.6 11180.6 11446.5 11452.2 11611.3 33460.0 34794.7 35903.3 37070.4 38349.0 48779.5 49075.5 50006.7 50314.3 50885.0 7008.1 7065.3 7117.3 7121.9 7136.9 12054.8 12644.8 12669.1 12916.4 12920.3 10875.7 11066.9 11207.0 11262.6 11357.6 10860.9 10998.6 11049.7 11082.7 11115.6 8160.3 9691.6 11420.9 11525.2 11582.2 6830.1 6887.0 6899.7 7025.0 7036.7 10789.7 10867.7 10889.3 11028.1 11253.4 13:21:46 INFO - 2015-11-19 13:21:46,339 DEBUG : BROWSER_OUTPUT: 13:21:46 INFO - 2015-11-19 13:21:46,339 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5491.89 Median:6682.23 stddev:2834.78 (42.4%) stddev-sans-first:2825.98 13:21:46 INFO - 2015-11-19 13:21:46,339 DEBUG : BROWSER_OUTPUT: Values: 1391.1 1756.5 1768.0 1769.5 1804.0 6784.8 7738.1 7875.6 7892.9 7899.6 7582.8 7708.2 7709.8 7714.8 7718.5 2030.1 2069.1 2071.4 2288.5 2308.6 2332.9 2390.4 2394.7 2395.4 2397.1 2235.6 2265.2 2275.5 2277.2 2279.4 1983.8 2039.9 2274.0 2290.8 2345.8 2290.6 2312.7 2319.9 2322.4 2324.6 7754.4 7868.4 7872.3 7882.7 7883.4 4813.3 4860.3 4877.9 4902.1 4904.0 3184.1 3201.5 3250.2 3253.9 3286.9 1026.5 1046.9 1067.3 1078.0 1124.7 10667.5 10676.0 10682.8 10686.0 10688.8 4461.6 4489.9 4587.2 4621.7 4643.6 8812.9 8828.3 8885.8 8887.2 8891.2 4850.7 4864.3 4873.3 4900.3 4914.5 4377.9 4420.7 4450.0 4475.8 4476.3 3605.0 3623.2 3631.4 3650.1 3655.4 1131.5 1135.9 1150.3 1163.4 1164.3 915.5 970.5 1068.9 1088.7 1091.0 6705.3 6821.2 6825.1 6826.8 7441.7 671.3 675.3 676.6 707.7 719.8 5860.2 5914.0 5914.5 5918.1 5921.9 9081.5 9099.6 9298.1 9345.0 9373.5 9453.7 9487.1 9516.6 9536.2 9556.0 7226.5 7265.8 7312.9 7318.1 7372.9 7369.1 7471.1 7474.1 7477.1 7477.2 8102.4 8246.8 8247.4 8393.9 8457.4 8501.1 8563.9 8725.3 8732.0 8741.0 6890.0 7138.6 7139.8 7142.7 7144.4 7580.3 7687.0 7690.2 7727.1 7740.8 7029.7 7084.1 7196.0 7204.4 7244.7 7027.2 7049.0 7122.3 7133.9 7210.1 6336.9 6456.4 7094.4 7137.2 7167.0 6433.6 6582.1 6672.1 6679.6 6684.9 6609.5 6632.6 6689.6 6715.4 6716.0 13:21:46 INFO - 2015-11-19 13:21:46,339 DEBUG : BROWSER_OUTPUT: 13:21:46 INFO - 2015-11-19 13:21:46,339 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5453.85 Median:6183.67 stddev:1663.45 (26.9%) stddev-sans-first:1623.19 13:21:46 INFO - 2015-11-19 13:21:46,340 DEBUG : BROWSER_OUTPUT: Values: 338.2 342.2 342.3 344.3 345.3 6076.3 6146.6 6150.5 6150.8 6156.0 5782.6 5912.9 5969.7 6021.8 6028.4 4690.8 4721.6 4729.2 4731.2 4744.5 4718.4 4721.2 4728.8 4730.6 4731.6 4461.4 4547.3 4550.5 4552.4 4554.2 4660.1 4660.1 4664.6 4674.2 4674.3 4110.3 4114.0 4114.3 4115.7 4134.3 5764.4 5767.3 5770.9 5770.9 5771.9 5302.2 5405.2 5407.1 5409.6 5409.8 6445.0 6468.8 6473.3 6474.3 6483.5 4431.6 4434.5 4436.4 4437.1 4451.2 6591.3 6660.7 6744.9 6746.8 6758.8 4534.1 4541.5 4547.7 4551.6 4553.3 4595.9 4600.0 4600.9 4605.4 4607.4 5333.4 5345.3 5361.0 5362.5 5371.7 6309.7 6460.7 6466.4 6473.2 6561.2 1628.9 1648.5 1649.5 1650.8 1651.9 1086.4 1087.2 1087.4 1100.2 1107.5 6314.8 6319.1 6322.7 6325.5 6327.7 6727.0 6736.4 6741.2 6746.6 6747.1 6108.0 6211.3 6291.0 6361.4 6369.6 3645.4 3648.7 3669.6 3673.9 3678.4 7032.9 7040.3 7041.8 7046.6 7050.0 6743.0 6904.1 6917.8 7001.1 7009.8 7056.6 7077.2 7078.1 7080.6 7090.0 6580.4 6768.2 6821.5 6831.8 6834.4 6725.6 6731.2 6742.4 6753.0 6756.7 7063.4 7065.0 7065.5 7066.2 7071.1 4509.1 4573.0 4604.1 4605.4 4609.9 6765.5 6777.3 6783.2 6785.2 6785.7 6598.3 6600.4 6604.1 6605.3 6616.1 6452.7 6583.8 6597.6 6602.1 6603.5 6472.5 6479.0 6479.3 6483.4 6485.1 6631.4 6639.2 6642.2 6642.5 6646.5 6337.0 6438.8 6458.7 6469.4 6472.3 13:21:46 INFO - 2015-11-19 13:21:46,340 DEBUG : BROWSER_OUTPUT: 13:21:46 INFO - 2015-11-19 13:21:46,340 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13747.46 Median:48559.76 stddev:16726.64 (34.4%) stddev-sans-first:16745.57 13:21:46 INFO - 2015-11-19 13:21:46,340 DEBUG : BROWSER_OUTPUT: Values: 860.0 862.3 869.0 880.4 889.7 14158.6 14465.8 14481.9 14489.1 14489.7 13423.9 13640.1 13654.1 13677.4 13680.4 841.0 848.1 849.0 850.5 851.6 694.9 704.6 836.0 841.0 842.1 875.1 886.2 887.6 887.7 891.3 878.7 882.4 885.4 885.8 885.8 531.2 534.9 637.5 650.0 650.3 13021.5 13103.6 13147.1 13221.0 13234.5 12317.8 13049.6 13151.3 13291.7 13298.6 10277.2 10396.4 10629.1 10875.2 10889.8 3272.0 3289.6 3298.2 3393.8 3404.3 45860.3 46265.3 46621.8 46722.3 47292.8 7596.3 7616.4 7700.0 7706.3 7771.8 12908.7 12920.0 12927.2 13052.5 13064.0 6824.6 6856.3 6861.2 7006.9 7099.4 4314.8 4426.9 4440.9 4518.1 4518.9 2771.4 2799.9 2806.2 2818.4 2821.2 441.2 450.1 455.3 461.1 464.8 679.8 682.7 698.8 702.0 724.1 8718.3 8753.3 8778.0 8819.2 8989.9 627.2 640.3 671.2 691.6 708.9 4042.6 4135.3 4161.7 4162.9 4261.8 60601.1 62038.7 62054.0 62078.7 62091.0 52496.0 52640.0 53010.7 53179.0 53636.5 48511.5 48608.0 48979.8 49124.8 49587.0 8119.6 8308.7 8319.3 8432.5 8452.4 36870.1 37156.8 37192.8 37582.8 37753.2 43272.4 47272.5 47656.3 48193.5 48304.5 7389.0 7445.8 7640.1 7712.8 7965.8 11223.2 11292.2 11375.1 11469.3 11962.5 10546.3 10580.0 10716.1 10873.8 11035.7 10300.1 10392.4 10611.6 10756.3 11087.5 10268.9 10695.5 10702.9 10787.6 10894.7 9034.4 9243.0 9251.1 9492.7 9523.9 8586.6 8686.3 8862.0 9342.5 9345.5 13:21:46 INFO - 2015-11-19 13:21:46,340 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:21:46 INFO - 2015-11-19 13:21:46,340 DEBUG : BROWSER_OUTPUT: 13:21:47 INFO - 2015-11-19 13:21:47,029 INFO : Browser exited with error code: 0 13:21:47 INFO - 2015-11-19 13:21:47,050 INFO : Completed test dromaeo_css (00:18:33) 13:21:47 INFO - 2015-11-19 13:21:47,050 INFO : Starting test kraken 13:21:47 INFO - 2015-11-19 13:21:47,051 DEBUG : operating with platform_type : linux_ 13:21:47 INFO - 2015-11-19 13:21:47,051 INFO : Initialising browser for kraken test... 13:21:47 INFO - 2015-11-19 13:21:47,057 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5_tpVz/profile http://localhost:50313/getInfo.html 13:21:51 INFO - 2015-11-19 13:21:51,095 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:21:51 INFO - 2015-11-19 13:21:51,095 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:21:51 INFO - 2015-11-19 13:21:51,095 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:21:51 INFO - 2015-11-19 13:21:51,095 DEBUG : BROWSER_OUTPUT: __metrics 13:21:51 INFO - 2015-11-19 13:21:51,292 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:21:52 INFO - 2015-11-19 13:21:52,577 INFO : Browser initialized. 13:21:52 INFO - 2015-11-19 13:21:52,577 INFO : Running cycle 1/1 for kraken test... 13:21:52 INFO - 2015-11-19 13:21:52,578 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5_tpVz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:22:04 INFO - 2015-11-19 13:22:04,336 DEBUG : BROWSER_OUTPUT: RSS: Main: 141795328 13:22:04 INFO - 2015-11-19 13:22:04,337 DEBUG : BROWSER_OUTPUT: 13:22:06 INFO - 2015-11-19 13:22:06,795 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50313/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50313/tests/kraken/driver.html?testName=audio-beat-detection) 13:22:07 INFO - 2015-11-19 13:22:07,377 DEBUG : BROWSER_OUTPUT: RSS: Main: 180043776 13:22:07 INFO - 2015-11-19 13:22:07,377 DEBUG : BROWSER_OUTPUT: 13:22:09 INFO - 2015-11-19 13:22:09,957 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50313/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50313/tests/kraken/driver.html?testName=audio-dft) 13:22:10 INFO - 2015-11-19 13:22:10,524 DEBUG : BROWSER_OUTPUT: RSS: Main: 169816064 13:22:10 INFO - 2015-11-19 13:22:10,524 DEBUG : BROWSER_OUTPUT: 13:22:13 INFO - 2015-11-19 13:22:13,414 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50313/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50313/tests/kraken/driver.html?testName=audio-fft) 13:22:13 INFO - 2015-11-19 13:22:13,976 DEBUG : BROWSER_OUTPUT: RSS: Main: 152977408 13:22:13 INFO - 2015-11-19 13:22:13,976 DEBUG : BROWSER_OUTPUT: 13:22:15 INFO - 2015-11-19 13:22:15,933 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50313/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50313/tests/kraken/driver.html?testName=audio-oscillator) 13:22:16 INFO - 2015-11-19 13:22:16,506 DEBUG : BROWSER_OUTPUT: RSS: Main: 155480064 13:22:16 INFO - 2015-11-19 13:22:16,506 DEBUG : BROWSER_OUTPUT: 13:22:18 INFO - 2015-11-19 13:22:18,640 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50313/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50313/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:22:19 INFO - 2015-11-19 13:22:19,192 DEBUG : BROWSER_OUTPUT: RSS: Main: 155770880 13:22:19 INFO - 2015-11-19 13:22:19,193 DEBUG : BROWSER_OUTPUT: 13:22:22 INFO - 2015-11-19 13:22:22,097 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50313/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50313/tests/kraken/driver.html?testName=imaging-darkroom) 13:22:22 INFO - 2015-11-19 13:22:22,671 DEBUG : BROWSER_OUTPUT: RSS: Main: 156299264 13:22:22 INFO - 2015-11-19 13:22:22,671 DEBUG : BROWSER_OUTPUT: 13:22:26 INFO - 2015-11-19 13:22:26,040 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50313/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50313/tests/kraken/driver.html?testName=imaging-desaturate) 13:22:26 INFO - 2015-11-19 13:22:26,607 DEBUG : BROWSER_OUTPUT: RSS: Main: 157372416 13:22:26 INFO - 2015-11-19 13:22:26,607 DEBUG : BROWSER_OUTPUT: 13:22:29 INFO - 2015-11-19 13:22:29,410 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50313/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50313/tests/kraken/driver.html?testName=json-parse-financial) 13:22:29 INFO - 2015-11-19 13:22:29,983 DEBUG : BROWSER_OUTPUT: RSS: Main: 156438528 13:22:29 INFO - 2015-11-19 13:22:29,983 DEBUG : BROWSER_OUTPUT: 13:22:31 INFO - 2015-11-19 13:22:31,536 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50313/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50313/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:22:32 INFO - 2015-11-19 13:22:32,097 DEBUG : BROWSER_OUTPUT: RSS: Main: 164548608 13:22:32 INFO - 2015-11-19 13:22:32,098 DEBUG : BROWSER_OUTPUT: 13:22:33 INFO - 2015-11-19 13:22:33,916 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50313/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50313/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:22:34 INFO - 2015-11-19 13:22:34,505 DEBUG : BROWSER_OUTPUT: RSS: Main: 163631104 13:22:34 INFO - 2015-11-19 13:22:34,505 DEBUG : BROWSER_OUTPUT: 13:22:36 INFO - 2015-11-19 13:22:36,542 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50313/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50313/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:22:37 INFO - 2015-11-19 13:22:37,109 DEBUG : BROWSER_OUTPUT: RSS: Main: 172384256 13:22:37 INFO - 2015-11-19 13:22:37,109 DEBUG : BROWSER_OUTPUT: 13:22:39 INFO - 2015-11-19 13:22:39,503 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50313/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50313/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:22:40 INFO - 2015-11-19 13:22:40,083 DEBUG : BROWSER_OUTPUT: RSS: Main: 178987008 13:22:40 INFO - 2015-11-19 13:22:40,083 DEBUG : BROWSER_OUTPUT: 13:22:42 INFO - 2015-11-19 13:22:42,599 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50313/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50313/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:22:43 INFO - 2015-11-19 13:22:43,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 177377280 13:22:43 INFO - 2015-11-19 13:22:43,167 DEBUG : BROWSER_OUTPUT: 13:22:44 INFO - 2015-11-19 13:22:44,828 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50313/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50313/tests/kraken/driver.html?testName=ai-astar) 13:22:45 INFO - 2015-11-19 13:22:45,078 DEBUG : BROWSER_OUTPUT: RSS: Main: 236380160 13:22:45 INFO - 2015-11-19 13:22:45,078 DEBUG : BROWSER_OUTPUT: 13:22:45 INFO - 2015-11-19 13:22:45,079 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:22:45 INFO - 2015-11-19 13:22:45,081 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:22:45 INFO - 2015-11-19 13:22:45,081 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:22:45 INFO - 2015-11-19 13:22:45,081 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:22:45 INFO - 2015-11-19 13:22:45,081 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;109;103;109;109;109;101;111;109;111 13:22:45 INFO - 2015-11-19 13:22:45,081 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;124;148;170;125;149;146;123;160;125 13:22:45 INFO - 2015-11-19 13:22:45,081 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;162;161;162;163;164;162;160;161 13:22:45 INFO - 2015-11-19 13:22:45,082 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;82;92;72;72;77;125;97;72 13:22:45 INFO - 2015-11-19 13:22:45,082 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;89;131;89;90;91;139;91;90;130 13:22:45 INFO - 2015-11-19 13:22:45,082 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;109;109;110;109;110;110;109;110;108 13:22:45 INFO - 2015-11-19 13:22:45,082 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;146;145;145;144;146;145;145;146 13:22:45 INFO - 2015-11-19 13:22:45,082 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;96;97;96;96;96;96;96 13:22:45 INFO - 2015-11-19 13:22:45,082 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;56;56;56;57;57;59;64;55;54 13:22:45 INFO - 2015-11-19 13:22:45,082 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;68;68;69;69;69;69;68;70 13:22:45 INFO - 2015-11-19 13:22:45,082 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;84;93;82;83;84;83;84;86;86 13:22:45 INFO - 2015-11-19 13:22:45,083 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;121;123;111;122;116;117;122;120;130 13:22:45 INFO - 2015-11-19 13:22:45,083 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;147;146;145;141;138;147;147;151;137 13:22:45 INFO - 2015-11-19 13:22:45,083 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;67;65;66;67;67;65;66;68;66 13:22:45 INFO - 2015-11-19 13:22:45,083 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:22:45 INFO - 2015-11-19 13:22:45,083 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:22:45 INFO - 2015-11-19 13:22:45,083 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,899 13:22:45 INFO - 2015-11-19 13:22:45,083 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:22:45 INFO - 2015-11-19 13:22:45,084 DEBUG : BROWSER_OUTPUT: __startTimestamp1447968165079__endTimestamp 13:22:45 INFO - 2015-11-19 13:22:45,084 DEBUG : BROWSER_OUTPUT: 13:22:45 INFO - 2015-11-19 13:22:45,087 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:22:45 INFO - 2015-11-19 13:22:45,087 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:22:45 INFO - 2015-11-19 13:22:45,088 DEBUG : BROWSER_OUTPUT: 13:22:45 INFO - 2015-11-19 13:22:45,088 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.90 Median:109.00 stddev:3.28 (3.0%) stddev-sans-first:3.48 13:22:45 INFO - 2015-11-19 13:22:45,088 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 103.0 109.0 109.0 109.0 101.0 111.0 109.0 111.0 13:22:45 INFO - 2015-11-19 13:22:45,088 DEBUG : BROWSER_OUTPUT: 13:22:45 INFO - 2015-11-19 13:22:45,088 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.20 Median:148.50 stddev:16.90 (11.4%) stddev-sans-first:17.55 13:22:45 INFO - 2015-11-19 13:22:45,089 DEBUG : BROWSER_OUTPUT: Values: 152.0 124.0 148.0 170.0 125.0 149.0 146.0 123.0 160.0 125.0 13:22:45 INFO - 2015-11-19 13:22:45,089 DEBUG : BROWSER_OUTPUT: 13:22:45 INFO - 2015-11-19 13:22:45,089 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 13:22:45 INFO - 2015-11-19 13:22:45,089 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 162.0 161.0 162.0 163.0 164.0 162.0 160.0 161.0 13:22:45 INFO - 2015-11-19 13:22:45,089 DEBUG : BROWSER_OUTPUT: 13:22:45 INFO - 2015-11-19 13:22:45,089 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:83.20 Median:74.50 stddev:17.34 (23.3%) stddev-sans-first:17.82 13:22:45 INFO - 2015-11-19 13:22:45,089 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 82.0 92.0 72.0 72.0 77.0 125.0 97.0 72.0 13:22:45 INFO - 2015-11-19 13:22:45,089 DEBUG : BROWSER_OUTPUT: 13:22:45 INFO - 2015-11-19 13:22:45,090 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.90 Median:89.50 stddev:21.14 (23.6%) stddev-sans-first:21.82 13:22:45 INFO - 2015-11-19 13:22:45,090 DEBUG : BROWSER_OUTPUT: Values: 89.0 89.0 131.0 89.0 90.0 91.0 139.0 91.0 90.0 130.0 13:22:45 INFO - 2015-11-19 13:22:45,090 DEBUG : BROWSER_OUTPUT: 13:22:45 INFO - 2015-11-19 13:22:45,090 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.85 (0.8%) stddev-sans-first:0.71 13:22:45 INFO - 2015-11-19 13:22:45,090 DEBUG : BROWSER_OUTPUT: Values: 111.0 109.0 109.0 110.0 109.0 110.0 110.0 109.0 110.0 108.0 13:22:45 INFO - 2015-11-19 13:22:45,090 DEBUG : BROWSER_OUTPUT: 13:22:45 INFO - 2015-11-19 13:22:45,090 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 13:22:45 INFO - 2015-11-19 13:22:45,090 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 146.0 145.0 145.0 144.0 146.0 145.0 145.0 146.0 13:22:45 INFO - 2015-11-19 13:22:45,090 DEBUG : BROWSER_OUTPUT: 13:22:45 INFO - 2015-11-19 13:22:45,090 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 13:22:45 INFO - 2015-11-19 13:22:45,090 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 13:22:45 INFO - 2015-11-19 13:22:45,090 DEBUG : BROWSER_OUTPUT: 13:22:45 INFO - 2015-11-19 13:22:45,090 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.10 Median:57.00 stddev:2.77 (4.9%) stddev-sans-first:2.93 13:22:45 INFO - 2015-11-19 13:22:45,091 DEBUG : BROWSER_OUTPUT: Values: 57.0 56.0 56.0 56.0 57.0 57.0 59.0 64.0 55.0 54.0 13:22:45 INFO - 2015-11-19 13:22:45,091 DEBUG : BROWSER_OUTPUT: 13:22:45 INFO - 2015-11-19 13:22:45,091 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 13:22:45 INFO - 2015-11-19 13:22:45,091 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 68.0 69.0 69.0 69.0 69.0 68.0 70.0 13:22:45 INFO - 2015-11-19 13:22:45,091 DEBUG : BROWSER_OUTPUT: 13:22:45 INFO - 2015-11-19 13:22:45,091 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.00 stddev:3.23 (3.8%) stddev-sans-first:3.28 13:22:45 INFO - 2015-11-19 13:22:45,091 DEBUG : BROWSER_OUTPUT: Values: 82.0 84.0 93.0 82.0 83.0 84.0 83.0 84.0 86.0 86.0 13:22:45 INFO - 2015-11-19 13:22:45,091 DEBUG : BROWSER_OUTPUT: 13:22:45 INFO - 2015-11-19 13:22:45,091 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.60 Median:122.00 stddev:5.13 (4.2%) stddev-sans-first:5.29 13:22:45 INFO - 2015-11-19 13:22:45,091 DEBUG : BROWSER_OUTPUT: Values: 124.0 121.0 123.0 111.0 122.0 116.0 117.0 122.0 120.0 130.0 13:22:45 INFO - 2015-11-19 13:22:45,091 DEBUG : BROWSER_OUTPUT: 13:22:45 INFO - 2015-11-19 13:22:45,091 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.70 Median:146.50 stddev:4.83 (3.3%) stddev-sans-first:4.66 13:22:45 INFO - 2015-11-19 13:22:45,091 DEBUG : BROWSER_OUTPUT: Values: 138.0 147.0 146.0 145.0 141.0 138.0 147.0 147.0 151.0 137.0 13:22:45 INFO - 2015-11-19 13:22:45,091 DEBUG : BROWSER_OUTPUT: 13:22:45 INFO - 2015-11-19 13:22:45,091 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.50 stddev:1.03 (1.6%) stddev-sans-first:1.00 13:22:45 INFO - 2015-11-19 13:22:45,091 DEBUG : BROWSER_OUTPUT: Values: 65.0 67.0 65.0 66.0 67.0 67.0 65.0 66.0 68.0 66.0 13:22:45 INFO - 2015-11-19 13:22:45,092 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:22:45 INFO - 2015-11-19 13:22:45,092 DEBUG : BROWSER_OUTPUT: 13:22:45 INFO - 2015-11-19 13:22:45,869 INFO : Browser exited with error code: 0 13:22:45 INFO - 2015-11-19 13:22:45,920 INFO : Completed test kraken (00:00:58) 13:22:45 INFO - 2015-11-19 13:22:45,920 INFO : Starting test v8_7 13:22:45 INFO - 2015-11-19 13:22:45,920 DEBUG : operating with platform_type : linux_ 13:22:45 INFO - 2015-11-19 13:22:45,920 INFO : Initialising browser for v8_7 test... 13:22:45 INFO - 2015-11-19 13:22:45,926 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9FrgJR/profile http://localhost:50313/getInfo.html 13:22:49 INFO - 2015-11-19 13:22:49,990 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:22:49 INFO - 2015-11-19 13:22:49,990 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:22:49 INFO - 2015-11-19 13:22:49,990 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:22:49 INFO - 2015-11-19 13:22:49,990 DEBUG : BROWSER_OUTPUT: __metrics 13:22:50 INFO - 2015-11-19 13:22:50,167 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:22:51 INFO - 2015-11-19 13:22:51,446 INFO : Browser initialized. 13:22:51 INFO - 2015-11-19 13:22:51,447 INFO : Running cycle 1/1 for v8_7 test... 13:22:51 INFO - 2015-11-19 13:22:51,447 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9FrgJR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:23:03 INFO - 2015-11-19 13:23:03,201 DEBUG : BROWSER_OUTPUT: RSS: Main: 140959744 13:23:03 INFO - 2015-11-19 13:23:03,202 DEBUG : BROWSER_OUTPUT: 13:23:24 INFO - 2015-11-19 13:23:24,633 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50313/tests/v8_7/run.html (next: http://localhost:50313/tests/v8_7/run.html) 13:23:24 INFO - 2015-11-19 13:23:24,892 DEBUG : BROWSER_OUTPUT: RSS: Main: 608645120 13:23:24 INFO - 2015-11-19 13:23:24,892 DEBUG : BROWSER_OUTPUT: 13:23:24 INFO - 2015-11-19 13:23:24,892 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:23:24 INFO - 2015-11-19 13:23:24,892 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:23:24 INFO - 2015-11-19 13:23:24,892 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:23:24 INFO - 2015-11-19 13:23:24,893 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:23:24 INFO - 2015-11-19 13:23:24,893 DEBUG : BROWSER_OUTPUT: |0;Richards;163.07893020221786 13:23:24 INFO - 2015-11-19 13:23:24,893 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.89378288832586 13:23:24 INFO - 2015-11-19 13:23:24,893 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.0102243680773 13:23:24 INFO - 2015-11-19 13:23:24,893 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5030.150753768844 13:23:24 INFO - 2015-11-19 13:23:24,893 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1108.6474501108648 13:23:24 INFO - 2015-11-19 13:23:24,893 DEBUG : BROWSER_OUTPUT: |5;Earley;778.816199376947 13:23:24 INFO - 2015-11-19 13:23:24,894 DEBUG : BROWSER_OUTPUT: |6;Boyer;12011.904761904761 13:23:24 INFO - 2015-11-19 13:23:24,894 DEBUG : BROWSER_OUTPUT: |7;RegExp;25350 13:23:24 INFO - 2015-11-19 13:23:24,894 DEBUG : BROWSER_OUTPUT: |8;Splay;674.7311827956989 13:23:24 INFO - 2015-11-19 13:23:24,894 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 13:23:24 INFO - 2015-11-19 13:23:24,894 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:23:24 INFO - 2015-11-19 13:23:24,894 DEBUG : BROWSER_OUTPUT: __startTimestamp1447968204885__endTimestamp 13:23:24 INFO - 2015-11-19 13:23:24,894 DEBUG : BROWSER_OUTPUT: 13:23:24 INFO - 2015-11-19 13:23:24,895 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:23:24 INFO - 2015-11-19 13:23:24,895 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:23:24 INFO - 2015-11-19 13:23:24,895 DEBUG : BROWSER_OUTPUT: 13:23:24 INFO - 2015-11-19 13:23:24,895 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.08 Median:163.08 stddev:0.00 (0.0%) 13:23:24 INFO - 2015-11-19 13:23:24,895 DEBUG : BROWSER_OUTPUT: Values: 163.1 13:23:24 INFO - 2015-11-19 13:23:24,895 DEBUG : BROWSER_OUTPUT: 13:23:24 INFO - 2015-11-19 13:23:24,895 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.89 Median:194.89 stddev:0.00 (0.0%) 13:23:24 INFO - 2015-11-19 13:23:24,895 DEBUG : BROWSER_OUTPUT: Values: 194.9 13:23:24 INFO - 2015-11-19 13:23:24,895 DEBUG : BROWSER_OUTPUT: 13:23:24 INFO - 2015-11-19 13:23:24,895 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.01 Median:284.01 stddev:0.00 (0.0%) 13:23:24 INFO - 2015-11-19 13:23:24,895 DEBUG : BROWSER_OUTPUT: Values: 284.0 13:23:24 INFO - 2015-11-19 13:23:24,895 DEBUG : BROWSER_OUTPUT: 13:23:24 INFO - 2015-11-19 13:23:24,895 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5030.15 Median:5030.15 stddev:0.00 (0.0%) 13:23:24 INFO - 2015-11-19 13:23:24,895 DEBUG : BROWSER_OUTPUT: Values: 5030.2 13:23:24 INFO - 2015-11-19 13:23:24,896 DEBUG : BROWSER_OUTPUT: 13:23:24 INFO - 2015-11-19 13:23:24,896 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1108.65 Median:1108.65 stddev:0.00 (0.0%) 13:23:24 INFO - 2015-11-19 13:23:24,896 DEBUG : BROWSER_OUTPUT: Values: 1108.6 13:23:24 INFO - 2015-11-19 13:23:24,896 DEBUG : BROWSER_OUTPUT: 13:23:24 INFO - 2015-11-19 13:23:24,896 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:778.82 Median:778.82 stddev:0.00 (0.0%) 13:23:24 INFO - 2015-11-19 13:23:24,896 DEBUG : BROWSER_OUTPUT: Values: 778.8 13:23:24 INFO - 2015-11-19 13:23:24,896 DEBUG : BROWSER_OUTPUT: 13:23:24 INFO - 2015-11-19 13:23:24,896 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12011.90 Median:12011.90 stddev:0.00 (0.0%) 13:23:24 INFO - 2015-11-19 13:23:24,896 DEBUG : BROWSER_OUTPUT: Values: 12011.9 13:23:24 INFO - 2015-11-19 13:23:24,896 DEBUG : BROWSER_OUTPUT: 13:23:24 INFO - 2015-11-19 13:23:24,896 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25350.00 Median:25350.00 stddev:0.00 (0.0%) 13:23:24 INFO - 2015-11-19 13:23:24,896 DEBUG : BROWSER_OUTPUT: Values: 25350.0 13:23:24 INFO - 2015-11-19 13:23:24,896 DEBUG : BROWSER_OUTPUT: 13:23:24 INFO - 2015-11-19 13:23:24,896 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:674.73 Median:674.73 stddev:0.00 (0.0%) 13:23:24 INFO - 2015-11-19 13:23:24,896 DEBUG : BROWSER_OUTPUT: Values: 674.7 13:23:24 INFO - 2015-11-19 13:23:24,896 DEBUG : BROWSER_OUTPUT: 13:23:24 INFO - 2015-11-19 13:23:24,897 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 13:23:24 INFO - 2015-11-19 13:23:24,897 DEBUG : BROWSER_OUTPUT: Values: 4835.7 13:23:24 INFO - 2015-11-19 13:23:24,897 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:23:24 INFO - 2015-11-19 13:23:24,897 DEBUG : BROWSER_OUTPUT: 13:23:25 INFO - 2015-11-19 13:23:25,789 INFO : Browser exited with error code: 0 13:23:25 INFO - 2015-11-19 13:23:25,806 INFO : Completed test v8_7 (00:00:39) 13:23:25 INFO - 2015-11-19 13:23:25,862 INFO : Completed test suite (00:20:12) 13:23:25 INFO - 2015-11-19 13:23:25,862 DEBUG : Working with test: dromaeo_css 13:23:25 INFO - 2015-11-19 13:23:25,862 DEBUG : Generating results file: dromaeo_css 13:23:25 INFO - 2015-11-19 13:23:25,864 DEBUG : Working with test: kraken 13:23:25 INFO - 2015-11-19 13:23:25,864 DEBUG : Generating results file: kraken 13:23:25 INFO - 2015-11-19 13:23:25,864 INFO : javascript benchmark 13:23:25 INFO - 2015-11-19 13:23:25,864 DEBUG : Working with test: v8_7 13:23:25 INFO - 2015-11-19 13:23:25,864 DEBUG : Generating results file: v8_7 13:23:25 INFO - 2015-11-19 13:23:25,865 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:23:25 INFO - 2015-11-19 13:23:25,910 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 13:23:25 INFO - 2015-11-19 13:23:25,911 DEBUG : process_Request line: dromaeo_css 6793.43 graph.html#tests=[[72,64,35]] 13:23:25 INFO - 2015-11-19 13:23:25,911 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:23:25 INFO - 2015-11-19 13:23:25,942 DEBUG : process_Request line: kraken 1490.00 graph.html#tests=[[232,64,35]] 13:23:25 INFO - 2015-11-19 13:23:25,942 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:23:25 INFO - 2015-11-19 13:23:25,974 DEBUG : process_Request line: v8_7 20911.08 graph.html#tests=[[230,64,35]] 13:23:25 INFO - 2015-11-19 13:23:25,975 INFO : javascript benchmark 13:23:26 INFO - 2015-11-19 13:23:25,979 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3217.2921957169424, 3267.0688853676706, 3310.966890331096, 3317.2536179359645, 3336.132605522564, 5301.231321458386, 5363.0, 5390.8921821563545, 5398.352197736267, 5411.053065713504, 5407.729613519318, 5433.0, 5462.535684466825, 5481.780728770845, 5525.281713377265, 4979.228219625964, 5000.074986127578, 5016.3227964224725, 5024.171011783052, 5102.897942041157, 4887.682300650464, 5039.521245481674, 5116.744162791864, 5128.282040514331, 5190.091733946563, 4982.551570358649, 5030.0694371541385, 5075.6447048706605, 5086.033653605803, 5087.898242035176, 5031.798728050873, 5050.747462626854, 5057.645964782467, 5063.417706963673, 5122.1036318644465, 4919.458859525449, 5020.723860187724, 5026.195808670595, 5031.547160755513, 5036.471170527115, 5234.345706786652, 5249.895002099975, 5343.625946183769, 5360.410354860962, 5379.273798037254, 5978.163057172, 5987.850303742398, 5989.431004054652, 5989.940100599026, 6004.309504407005, 5836.9124463133085, 6018.879622407571, 6022.8494287642725, 6028.246469191351, 6033.276006879159, 5473.480019398191, 5526.944730552724, 5531.1426728857095, 5535.916961245544, 5578.0, 6053.092036194518, 6073.331933487313, 6081.817545473643, 6086.300075491286, 6101.5118790497545, 5673.801416950387, 5900.586958912835, 5909.586328957018, 5910.320313164041, 5913.113033044991, 5835.79574714883, 5859.853503662357, 5862.208601838697, 5897.646141231454, 5949.494292985145, 5853.502452291603, 5909.734061967221, 5912.645241285537, 5913.438223368773, 5913.704314784243, 5675.2054712340305, 5794.565407594448, 5896.7641294348605, 5906.970465147647, 5916.083007133815, 4488.775561221991, 4530.682852200381, 4533.478649955231, 4571.22289210835, 4574.977125114353, 4060.0661847775177, 4072.165206132736, 4086.3053280942313, 4086.8773936781945, 4106.281400754856, 5422.457754224546, 5525.088360420566, 5648.915266271009, 5652.604317697804, 5655.4910058094965, 5882.235309409835, 5915.792947246911, 5957.046872500379, 5976.7908123215475, 5987.790427335022, 5636.126400407943, 5652.547796176296, 5652.943470565242, 5655.208270842086, 5659.434056594308, 4988.625853061035, 5060.418051924076, 5129.9230511542355, 5185.274061631375, 5204.635675502678, 6001.399860013964, 6119.816405507753, 6120.540959427972, 6129.448349648464, 6130.049842274455, 5942.61373010753, 5980.8803823924145, 5982.7307771149535, 5987.790427335022, 5991.670458124845, 5964.731587078679, 6074.848128796639, 6075.2405949256345, 6165.722542485689, 6168.414000669929, 5790.768369265183, 5859.560532959959, 5859.824205273849, 5874.853128671646, 5925.585209035326, 5924.31870334917, 5961.135635332939, 5966.627675634541, 5973.283206015306, 5976.432238937294, 5478.397376288525, 5669.518090962314, 5697.23087383198, 5827.970860145672, 5831.1544826000845, 5846.444587764156, 5847.210626565529, 5849.327327357409, 5850.0932355484965, 5894.145348924468, 5756.395578464201, 5757.222774925332, 5757.769689212385, 5760.395158508464, 5762.94237057624, 5697.800576979786, 5726.74229659658, 5773.942260577341, 5820.126980952721, 5857.033589457692, 5706.343770466449, 5739.770409183586, 5746.9712651436475, 5754.5684073695475, 5808.5062769665055], "unit": "ms", "name": "dojo.html", "value": 5458.959908265653}, {"lowerIsBetter": false, "replicates": [546.5809513620758, 575.625843201919, 583.3000399520577, 591.5356445190525, 592.7984485275006, 39786.40320395193, 40797.38803917944, 40818.7959060205, 40898.182036359256, 40906.795466022704, 44486.33270500937, 45390.09219815602, 45414.0, 45452.3182152268, 45456.318155227695, 7683.078030636303, 7789.610519474032, 8763.211310982026, 8940.374173807804, 10126.0, 10362.585496580128, 10470.319429237075, 10470.738231544196, 10488.737781555485, 10491.0, 10486.632967846126, 10563.524641391117, 10568.947155264252, 10572.577096916115, 10592.841107383396, 7936.5238085714755, 8104.351651867866, 10660.307080039773, 10880.401577913211, 10924.344539327665, 10344.293191623374, 10474.214433917487, 10475.371477711362, 10480.895191048068, 10487.003734645197, 40741.0, 41048.38427423591, 41165.176696465904, 41231.58768412308, 41256.38115428241, 3366.293078453528, 3373.3421982713135, 3387.830608469567, 3405.897823065312, 3434.210131669705, 29827.0, 30395.69604303951, 30751.538726919112, 31166.0, 31573.21066973321, 3521.9823900880333, 3559.982200088983, 3612.223371975038, 3663.835127419246, 3670.972127804219, 270819.0, 271497.0, 271775.0, 271902.999999998, 272022.0, 58081.419185808445, 59342.40657593369, 59657.0, 60045.699771501735, 60171.0, 68921.0, 69958.3004169962, 70247.29752702407, 70272.0, 70405.64797175981, 16167.272472738756, 16382.180890955642, 16429.424970125987, 16442.177891105635, 16448.342066317215, 11502.827457588142, 11557.364344960939, 11559.711007224718, 11620.0, 11625.24435911663, 19553.0, 19758.11088501021, 19803.306884258982, 19811.10850011753, 19830.305939292055, 7500.587467689329, 7520.0, 7597.658105385271, 7645.5794931279315, 7668.9616551918, 907.1654078248027, 910.8497097978892, 982.1308142293979, 986.7335819328741, 1072.9946350268356, 28705.861309988093, 29012.27469313284, 29019.70980290212, 29470.115896523137, 29726.554101688493, 1020.3010937507831, 1031.504877658728, 1037.486444210121, 1056.4717641179411, 1059.1050562274866, 13927.303634818421, 14288.928555357157, 14294.85705142956, 15237.466688665843, 15623.531294061197, 319957.0, 327122.0, 327411.0, 327580.0, 327741.0, 54533.45466545363, 54688.0, 55083.72458137684, 55128.0, 55222.723886381114, 1379.9507731019428, 1384.1694983010314, 1392.3316807932047, 1400.9089409188573, 1410.8448070712213, 28282.2929426766, 28652.71347286584, 29024.564631530968, 29250.707492924797, 29311.7068829309, 42977.0, 44526.3321050191, 46287.537124628325, 46774.0, 46972.7651361741, 300032.0, 306539.0, 306631.0, 308868.0, 309205.0, 28653.0, 28798.136055918356, 29154.562681559368, 29465.263368415963, 29543.409131817672, 39041.60958390493, 39954.0, 39963.40054899237, 40329.1934161321, 40440.59559404368, 33437.498437523944, 33627.49558756572, 34050.0, 36015.27969440649, 37291.81354093212, 33151.63231952769, 33486.66513334835, 34124.31751364909, 34339.4849077269, 34517.137071572404, 33400.33199336048, 33721.0, 33814.49278260779, 34218.82890585531, 34218.973430797116, 30472.0, 30606.0, 31245.375092498478, 31487.84256078705, 31488.527672084478, 23203.883980580664, 24227.51544969126, 24963.500729985662, 25070.247892563253, 25169.49661006806], "unit": "ms", "name": "ext.html", "value": 18836.346049154625}, {"lowerIsBetter": false, "replicates": [357.66445113409446, 359.35854499718, 359.46619270383474, 360.86647940262105, 362.82040390006915, 14453.349599268033, 14757.40970361187, 16838.747418788713, 17273.481795546137, 17958.999999999985, 12080.214786038901, 12345.0, 16553.337866485355, 17073.060981646006, 17076.829231707678, 4569.497355290915, 4670.76646167692, 4671.439427268716, 4675.2052151134385, 4686.226772582537, 3555.5911070226866, 3647.106458917569, 4618.445786505607, 5048.1165795985735, 5141.562967147797, 5014.548690617844, 5050.898982020376, 5070.797168113271, 5082.51716086973, 5108.208227724708, 4744.312074749142, 4744.762761861911, 4773.188557945157, 4886.609071274307, 5086.186210206368, 4374.190774706658, 4444.488883778375, 4445.822167113344, 4455.086707225011, 4456.955430445686, 14019.719605607932, 14087.577372678836, 14359.569212923629, 14535.345909433996, 14537.927310363486, 1980.1386396917244, 2006.6388050150968, 2034.5829105033433, 2102.8633138845926, 2228.6545585434283, 10158.746031349201, 10277.31893424092, 10303.27877048607, 10334.844977325347, 10453.47732613374, 1659.9585010374717, 1675.8072821625547, 1687.1648533975638, 1706.4198172621245, 1743.59897223638, 62699.37300627027, 62767.37232627661, 63559.68220158916, 63679.68160159216, 64690.67654661743, 7010.474214433836, 7101.076860008269, 7142.750003749844, 7182.676779544933, 7199.784006479814, 8594.441361311494, 8603.741887743377, 8605.526696031653, 8606.956965215133, 8611.913880861237, 5739.624582411664, 5753.510951569164, 5755.1079582663915, 5785.50823180026, 5792.073268277056, 5872.29532456108, 5913.970430147821, 5927.911081333784, 5938.168656388109, 6046.09308603713, 3290.144562413742, 3293.8023718576483, 3333.8999830005137, 3340.732741380684, 3360.899173024813, 1131.4455916600807, 1155.7746239483388, 1175.5415387998687, 1179.5517703272874, 1220.8718084601167, 469.2210929856422, 472.0723777776617, 473.5477618873967, 474.23174457379264, 519.5246349590158, 11762.294262344287, 11820.527178912747, 11868.258362855006, 11907.940460297643, 12350.3824808761, 460.10509558907603, 495.9851204463872, 510.72165669710097, 523.0663266070122, 539.5198273536556, 6482.967585162044, 6853.0, 6875.106236189264, 6917.412019978358, 7087.716491340392, 538500.0, 544658.0, 555152.0, 560061.0, 563711.0, 77738.6113069431, 81036.59481702554, 83453.0, 84131.0, 84426.0, 553.485258709396, 561.1190431023255, 565.3018522125254, 566.1620801214144, 566.8412844403574, 10914.563417463212, 11180.608678696206, 11446.484908179318, 11452.198346116025, 11611.303321800719, 33460.0, 34794.65205348015, 35903.28193436169, 37070.44394334033, 38349.041273968374, 48779.51220487892, 49075.50924490852, 50006.74996624994, 50314.28386576725, 50885.0, 7008.053912721717, 7065.258147894603, 7117.252688467636, 7121.893171602534, 7136.857262854817, 12054.819177712166, 12644.810327845275, 12669.113162078935, 12916.354182291036, 12920.289384083966, 10875.728106797393, 11066.944665276622, 11207.0, 11262.605808796652, 11357.602483913024, 10860.945695271474, 10998.615048473264, 11049.668509944715, 11082.722931926444, 11115.555377784798, 8160.30637395828, 9691.612335506501, 11420.885791141982, 11525.193236473366, 11582.189246752647, 6830.077939478107, 6886.965565172342, 6899.689513971783, 7024.964875175591, 7036.683349249193, 10789.676309710721, 10867.728306792393, 10889.346639201673, 11028.062614677843, 11253.437328133397], "unit": "ms", "name": "jquery.html", "value": 7116.813741216379}, {"lowerIsBetter": false, "replicates": [1391.1027387335175, 1756.464278395089, 1767.9558011049721, 1769.4780039888233, 1804.0221312007027, 6784.830379240521, 7738.0714314282295, 7875.566843823587, 7892.881606775903, 7899.565523896198, 7582.84834303315, 7708.152103268636, 7709.807254818632, 7714.768556943287, 7718.536887786723, 2030.0560239488634, 2069.1206237349143, 2071.3785864240745, 2288.4507718147693, 2308.572914010905, 2332.93001209964, 2390.3546042568496, 2394.7485514021037, 2395.3652282145244, 2397.1010870923405, 2235.642297232443, 2265.2184996176375, 2275.4766403727153, 2277.1802151225547, 2279.3959600705825, 1983.8313743331835, 2039.9388018359473, 2274.033535747309, 2290.816734661223, 2345.7654234576576, 2290.6334986402094, 2312.664663623782, 2319.9420014499606, 2322.431004403915, 2324.628059510487, 7754.3796496280165, 7868.409869259771, 7872.291493765589, 7882.724104656367, 7883.408744344139, 4813.253945638432, 4860.270959356089, 4877.926831097537, 4902.142125128088, 4904.0191961607825, 3184.1402821238366, 3201.471757160066, 3250.1874531367157, 3253.869845206189, 3286.9342613147605, 1026.5277972132753, 1046.8900765419598, 1067.3062509368895, 1077.95688172473, 1124.7188202949262, 10667.466626668713, 10676.0, 10682.78634427307, 10686.038256556869, 10688.78622427555, 4461.643068554507, 4489.932651010237, 4587.151376995266, 4621.653375996813, 4643.558861908114, 8812.911870881337, 8828.293736501064, 8885.777855553662, 8887.15572020657, 8891.244244239182, 4850.684705494132, 4864.294677271776, 4873.342098816614, 4900.313956046157, 4914.508549145057, 4377.9124417511475, 4420.734755914656, 4449.955500444954, 4475.776211189427, 4476.283794592915, 3604.98197509016, 3623.202895363069, 3631.4371272452286, 3650.0874781304674, 3655.3603119453987, 1131.4964840645998, 1135.9091272698165, 1150.3385553306882, 1163.3543383422113, 1164.3246916788241, 915.455304094063, 970.4953424219508, 1068.930519516229, 1088.711491454765, 1091.0126335666234, 6705.2624211336715, 6821.2155602106395, 6825.1127353443735, 6826.761063362758, 7441.702331906663, 671.2817285504561, 675.2740803636111, 676.5940435738518, 707.734599525178, 719.8452332748379, 5860.179574859523, 5914.0, 5914.497267732205, 5918.082697181943, 5921.881562368729, 9081.54592270397, 9099.636014559343, 9298.070192980784, 9344.95327523358, 9373.48445835472, 9453.716388508356, 9487.098725621056, 9516.619335226513, 9536.2371010319, 9555.952220238993, 7226.494145409876, 7265.782026539212, 7312.890306645299, 7318.121825380988, 7372.852542949111, 7369.078865141857, 7471.103467583925, 7474.065741782278, 7477.140128885248, 7477.177510473953, 8102.4328297021, 8246.752597422086, 8247.422680412314, 8393.916060839314, 8457.40798144124, 8501.064882862756, 8563.914360856312, 8725.345599079967, 8731.995820480726, 8741.0, 6889.965550172217, 7138.607376594337, 7139.821504462222, 7142.714291428492, 7144.3570078693165, 7580.317771400601, 7687.0, 7690.230976902265, 7727.072751269883, 7740.8451830964195, 7029.683664235224, 7084.149902011792, 7196.0, 7204.387627051759, 7244.746433874789, 7027.15674119109, 7049.048378469046, 7122.323379278961, 7133.857322853618, 7210.098737657793, 6336.936630633819, 6456.386643268882, 7094.432445404458, 7137.179224389261, 7166.964165179141, 6433.613983161025, 6582.0785090086465, 6672.132622759011, 6679.56582822115, 6684.8997265042035, 6609.504287178384, 6632.602043877383, 6689.632070236184, 6715.3620406061345, 6715.966420168063], "unit": "ms", "name": "mootools.html", "value": 4467.392601805556}, {"lowerIsBetter": false, "replicates": [338.1596732120681, 342.1975467528645, 342.3119529745213, 344.3491800497061, 345.28181382723926, 6076.3316035236085, 6146.600470969383, 6150.477209437192, 6150.7539698412065, 6156.045812899008, 5782.566307526942, 5912.940870591293, 5969.731362088705, 6021.8193454196335, 6028.42729940656, 4690.765461726917, 4721.645876559254, 4729.172394830891, 4731.243001119821, 4744.501827308126, 4718.363020992174, 4721.197396442596, 4728.834490792823, 4730.645201609876, 4731.550502702255, 4461.442319710036, 4547.317902314663, 4550.544945505456, 4552.408186935694, 4554.225781617133, 4660.091282199973, 4660.114578230159, 4664.580187783115, 4674.182018146845, 4674.252119660872, 4110.34234522475, 4114.033202197481, 4114.341705327133, 4115.73247738899, 4134.3178375567995, 5764.365919748824, 5767.279090113736, 5770.913436298459, 5770.9422905770825, 5771.884562308773, 5302.2311764793885, 5405.243265942771, 5407.080796264644, 5409.6213265071465, 5409.83770486886, 6445.0, 6468.8059358219325, 6473.255575608819, 6474.320196379406, 6483.546151769378, 4431.645468362523, 4434.512203657595, 4436.378906953029, 4437.112577484484, 4451.243288640939, 6591.307912669196, 6660.733570657168, 6744.898826517606, 6746.763863264811, 6758.763443279461, 4534.070515544306, 4541.5231400703115, 4547.727136371828, 4551.635869130461, 4553.2942393929, 4595.908081838412, 4599.954000460019, 4600.907981840344, 4605.355250264965, 4607.447106347193, 5333.359996800409, 5345.251664766935, 5361.008213480519, 5362.544183744425, 5371.731413429313, 6309.652969086745, 6460.741570337228, 6466.385693359123, 6473.190851143607, 6561.179852518435, 1628.8778341624425, 1648.5054483654856, 1649.5051484554585, 1650.8101568319557, 1651.901485512145, 1086.440483151178, 1087.152021423291, 1087.4127970895786, 1100.2023532938715, 1107.5293000474926, 6314.810555683245, 6319.115323854664, 6322.747090116344, 6325.462335701517, 6327.683615819191, 6727.0, 6736.360045795642, 6741.157355330583, 6746.595204287759, 6747.122874026345, 6107.969460152671, 6211.2857021443115, 6290.968545157245, 6361.363863613602, 6369.554131210771, 3645.4167333226555, 3648.726345524043, 3669.5963444021136, 3673.8530458781884, 3678.356287649704, 7032.92967070333, 7040.295970402919, 7041.8239544010785, 7046.577205367695, 7049.964750176319, 6743.0, 6904.1024666794, 6917.792466226021, 7001.124859392576, 7009.824754381181, 7056.576605403589, 7077.186123595749, 7078.079849619517, 7080.610566418896, 7090.042844215965, 6580.374864387875, 6768.221654509597, 6821.522493425611, 6831.760888368884, 6834.419074378733, 6725.562838415487, 6731.225909020525, 6742.359475849787, 6752.966235168989, 6756.729730810909, 7063.364297213276, 7065.0, 7065.505414620927, 7066.187388450394, 7071.080759501232, 4509.07563949383, 4572.993941332901, 4604.148232576984, 4605.355250265033, 4609.907801844011, 6765.492588055817, 6777.322267773183, 6783.152105986752, 6785.219699734594, 6785.728570857308, 6598.274189839018, 6600.405963463311, 6604.075429439787, 6605.339466053356, 6616.073749675145, 6452.709628066842, 6583.80248592543, 6597.637129957899, 6602.075709400784, 6603.504737144829, 6472.546921715435, 6479.028145778171, 6479.254885688018, 6483.384078512534, 6485.059666348258, 6631.3700198481065, 6639.203295604559, 6642.2361428434415, 6642.4686025118845, 6646.501512386493, 6337.04944258365, 6438.806835794933, 6458.7093580789915, 6469.353064693493, 6472.320406357265], "unit": "ms", "name": "prototype.html", "value": 4912.0801686758605}, {"lowerIsBetter": false, "replicates": [859.9828003439932, 862.2713806833232, 868.9782755431115, 880.4145243413128, 889.6797153024914, 14158.575242742721, 14465.783013254782, 14481.855181448182, 14489.058211216277, 14489.710205795878, 13423.932880335584, 13640.113392629471, 13654.112482688643, 13677.384517696702, 13680.384382702778, 840.9831803363929, 848.1476116502906, 848.9897022543184, 850.4939560961249, 851.5912362066211, 694.8957656351563, 704.6089420371692, 835.9623816928222, 840.9915900841005, 842.0779246724826, 875.1030194051085, 886.1935638568904, 887.5562218890555, 887.6937456577502, 891.335954713736, 878.7188099808096, 882.4087861132992, 885.3935054487632, 885.7519894429538, 885.7696998780332, 531.2191079113696, 534.9144136938071, 637.4581605635173, 649.9967500162469, 650.3496503496503, 13021.479140834355, 13103.60689179326, 13147.0797044206, 13221.0, 13234.536791212262, 12317.753644927052, 13049.564547899723, 13151.342432878413, 13291.734165316737, 13298.601041968659, 10277.229207809369, 10396.376217426978, 10629.149668026539, 10875.184361172865, 10889.782204355948, 3272.0, 3289.6381398046196, 3298.191942973987, 3393.7624366294367, 3404.285100128976, 45860.31209531859, 46265.30602040972, 46621.766891165666, 46722.299165512544, 47292.7635361821, 7596.278353556403, 7616.35261002821, 7700.0, 7706.344960678293, 7771.844563108706, 12908.677283067811, 12920.0, 12927.224366538037, 13052.477900884049, 13064.020198485152, 6824.624645644537, 6856.348646878539, 6861.176658800876, 7006.894896576556, 7099.432045436352, 4314.784260787011, 4426.867193984185, 4440.878007934734, 4518.073794872043, 4518.887027824265, 2771.390294135287, 2799.9440011199663, 2806.1581525542256, 2818.4363127374195, 2821.195959151673, 441.216840108803, 450.1290003842575, 455.27156549521163, 461.06634066016585, 464.84195373573147, 679.7960611816534, 682.689376333767, 698.8427603789107, 701.9613921234279, 724.055108083945, 8718.346124040723, 8753.343499237582, 8778.0, 8819.206271435602, 8989.910100899038, 627.2128478759128, 640.3468462168562, 671.2012704881175, 691.640347019547, 708.9432845372461, 4042.636162745367, 4135.255653982252, 4161.667066634662, 4162.875113746592, 4261.786910654455, 60601.09098363528, 62038.689806550676, 62054.0, 62078.68960655258, 62091.0, 52496.0, 52640.0, 53010.73494632502, 53179.0, 53636.46363536315, 48511.5148848507, 48608.0, 48979.75510122427, 49124.75437622861, 49587.0, 8119.596505968419, 8308.70919517814, 8319.334453243848, 8432.45189062709, 8452.36607254446, 36870.07824804401, 37156.814215928745, 37192.814035929645, 37582.8120859394, 37753.24493510169, 43272.350914735674, 47272.52727472681, 47656.285155722, 48193.518064818905, 48304.516954830004, 7388.963055184905, 7445.7766267012075, 7640.083190017233, 7712.8457430852195, 7965.761027169194, 11223.15826313046, 11292.209545331747, 11375.146863985068, 11469.31184128955, 11962.521499139937, 10546.314489558154, 10580.0, 10716.089132423831, 10873.836892446778, 11035.710201991413, 10300.124489418484, 10392.376457412278, 10611.628592999208, 10756.300840445347, 11087.501062452047, 10268.897311026794, 10695.465226738477, 10702.89297107019, 10787.568497260021, 10894.727631808952, 9034.367594268339, 9242.953785231031, 9251.121143491358, 9492.715218543455, 9523.857142142735, 8586.64808084826, 8686.261667758312, 8862.0, 9342.517592955746, 9345.48599827016], "unit": "ms", "name": "yui.html", "value": 6120.483790950703}], "name": "dromaeo_css", "value": 6793.428685132388}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 103.0, 109.0, 109.0, 109.0, 101.0, 111.0, 109.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 107.9}, {"lowerIsBetter": true, "replicates": [152.0, 124.0, 148.0, 170.0, 125.0, 149.0, 146.0, 123.0, 160.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.2}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 161.0, 162.0, 163.0, 164.0, 162.0, 160.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.9}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 82.0, 92.0, 72.0, 72.0, 77.0, 125.0, 97.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 83.2}, {"lowerIsBetter": true, "replicates": [89.0, 89.0, 131.0, 89.0, 90.0, 91.0, 139.0, 91.0, 90.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 102.9}, {"lowerIsBetter": true, "replicates": [111.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 108.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 145.0, 145.0, 144.0, 146.0, 145.0, 145.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 56.0, 56.0, 57.0, 57.0, 59.0, 64.0, 55.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 57.1}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 68.0, 69.0, 69.0, 69.0, 69.0, 68.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 93.0, 82.0, 83.0, 84.0, 83.0, 84.0, 86.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.7}, {"lowerIsBetter": true, "replicates": [124.0, 121.0, 123.0, 111.0, 122.0, 116.0, 117.0, 122.0, 120.0, 130.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.6}, {"lowerIsBetter": true, "replicates": [138.0, 147.0, 146.0, 145.0, 141.0, 138.0, 147.0, 147.0, 151.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.7}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 65.0, 66.0, 67.0, 67.0, 65.0, 66.0, 68.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.2}], "name": "kraken", "value": 1490.0000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.07893020221786], "unit": "score", "name": "Richards", "value": 216.47186399999995}, {"lowerIsBetter": false, "replicates": [194.89378288832586], "unit": "score", "name": "DeltaBlue", "value": 339.25145799999996}, {"lowerIsBetter": false, "replicates": [284.0102243680773], "unit": "score", "name": "Encrypt", "value": 937.2233010000001}, {"lowerIsBetter": false, "replicates": [5030.150753768844], "unit": "score", "name": "Decrypt", "value": 52.91710189810189}, {"lowerIsBetter": false, "replicates": [1108.6474501108648], "unit": "score", "name": "RayTrace", "value": 667.4700779999998}, {"lowerIsBetter": false, "replicates": [778.816199376947], "unit": "score", "name": "Earley", "value": 855.7384919999998}, {"lowerIsBetter": false, "replicates": [12011.904761904761], "unit": "score", "name": "Boyer", "value": 55.483540138751295}, {"lowerIsBetter": false, "replicates": [25350.0], "unit": "score", "name": "RegExp", "value": 35.936291913214966}, {"lowerIsBetter": false, "replicates": [674.7311827956989], "unit": "score", "name": "Splay", "value": 120.77550597609557}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20911.0824977886}]} 13:23:26 INFO - RETURN: dromaeo_css: 6793.43 13:23:26 INFO - RETURN: kraken: 1490.00 13:23:26 INFO - RETURN: v8_7: 20911.08 13:23:26 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20911.08"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1490.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6793.43"}}} 13:23:26 INFO - Return code: 0 13:23:26 INFO - # TBPL SUCCESS # 13:23:26 INFO - Running post-action listener: _resource_record_post_action 13:23:26 INFO - Running post-run listener: _resource_record_post_run 13:23:27 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 20480; Write bytes: 263393280; Read time: 24; Write time: 214720 13:23:27 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 507904; Read time: 0; Write time: 48 13:23:27 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 20480; Write bytes: 262885376; Read time: 24; Write time: 214672 13:23:27 INFO - Running post-run listener: _upload_blobber_files 13:23:27 INFO - Blob upload gear active. 13:23:27 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:23:27 INFO - Copying logs to upload dir... 13:23:27 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1312.524723 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 52 secs) (at 2015-11-19 13:23:27.083172) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 13:23:27.088125) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1447964726.328778-1913886165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010179 build_url: 'https://queue.taskcluster.net/v1/task/wPqJ3IrNQ_qRgNqD2KWKIQ/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-19 13:23:27.141438) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 13:23:27.141798) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1447964726.328778-1913886165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 13:23:27.191501) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 13:23:27.194961) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 13:23:27.195380) ========= ========= Total master_lag: 0.26 =========