builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-044 starttime: 1447815382.15 results: success (0) buildid: 20151117173015 builduid: 012ecbf6ee8c498ebaf4cf1692b614a7 revision: 8e712e56faf8ef12537ad604f38bca4f06665a7b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.147105) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.147520) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.147813) ========= 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=0cff312cb257a7829adc5a5d000001df-1447814749.804333-1409711051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006653 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.177546) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.177831) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.207136) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.207433) ========= 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=0cff312cb257a7829adc5a5d000001df-1447814749.804333-1409711051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023207 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.254063) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.254337) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.254667) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.254947) ========= 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=0cff312cb257a7829adc5a5d000001df-1447814749.804333-1409711051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-17 18:56:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2015-11-17 18:56:22 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.203803 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.470563) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.470870) ========= 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=0cff312cb257a7829adc5a5d000001df-1447814749.804333-1409711051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.088414 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.569370) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:22.570081) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8e712e56faf8ef12537ad604f38bca4f06665a7b --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 8e712e56faf8ef12537ad604f38bca4f06665a7b --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=0cff312cb257a7829adc5a5d000001df-1447814749.804333-1409711051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-17 18:56:22,868 truncating revision to first 12 chars 2015-11-17 18:56:22,868 Setting DEBUG logging. 2015-11-17 18:56:22,868 attempt 1/10 2015-11-17 18:56:22,868 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8e712e56faf8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 18:56:23,122 unpacking tar archive at: fx-team-8e712e56faf8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.726527 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:23.308461) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:23.308757) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:23.317434) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:23.317793) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 18:56:23.318183) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-11-17 18:56:23.318625) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=0cff312cb257a7829adc5a5d000001df-1447814749.804333-1409711051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:56:23 INFO - MultiFileLogger online at 20151117 18:56:23 in /builds/slave/test-pgo 18:56:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 18:56:23 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:56:23 INFO - {'append_to_log': False, 18:56:23 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:56:23 INFO - 'blob_upload_branch': 'Fx-Team', 18:56:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:56:23 INFO - 'branch': 'Fx-Team', 18:56:23 INFO - 'buildbot_json_path': 'buildprops.json', 18:56:23 INFO - 'config_files': ('talos/linux_config.py',), 18:56:23 INFO - 'default_actions': ('clobber', 18:56:23 INFO - 'read-buildbot-config', 18:56:23 INFO - 'download-and-extract', 18:56:23 INFO - 'populate-webroot', 18:56:23 INFO - 'create-virtualenv', 18:56:23 INFO - 'install', 18:56:23 INFO - 'run-tests'), 18:56:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:56:23 INFO - 'download_minidump_stackwalk': True, 18:56:23 INFO - 'download_symbols': 'ondemand', 18:56:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:56:23 INFO - 'tooltool.py': '/tools/tooltool.py', 18:56:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:56:23 INFO - '/tools/misc-python/virtualenv.py')}, 18:56:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:56:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:56:23 INFO - 'installer_path': 'installer.exe', 18:56:23 INFO - 'log_level': 'info', 18:56:23 INFO - 'log_name': 'talos', 18:56:23 INFO - 'log_to_console': True, 18:56:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:56:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:56:23 INFO - 'opt_config_files': (), 18:56:23 INFO - 'pip_index': False, 18:56:23 INFO - 'sps_profile': False, 18:56:23 INFO - 'sps_profile_interval': 0, 18:56:23 INFO - 'suite': 'dromaeojs-e10s', 18:56:23 INFO - 'system_bits': '64', 18:56:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:56:23 INFO - 'title': 'talos-linux64-ix-044', 18:56:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:56:23 INFO - 'use_talos_json': True, 18:56:23 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:56:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:56:23 INFO - 'work_dir': 'build'} 18:56:23 INFO - ##### 18:56:23 INFO - ##### Running clobber step. 18:56:23 INFO - ##### 18:56:23 INFO - Running pre-action listener: _resource_record_pre_action 18:56:23 INFO - Running main action method: clobber 18:56:23 INFO - rmtree: /builds/slave/test-pgo/build 18:56:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:56:29 INFO - Running post-action listener: _resource_record_post_action 18:56:29 INFO - ##### 18:56:29 INFO - ##### Running read-buildbot-config step. 18:56:29 INFO - ##### 18:56:29 INFO - Running pre-action listener: _resource_record_pre_action 18:56:29 INFO - Running main action method: read_buildbot_config 18:56:29 INFO - Using buildbot properties: 18:56:29 INFO - { 18:56:29 INFO - "properties": { 18:56:29 INFO - "buildnumber": 93, 18:56:29 INFO - "product": "firefox", 18:56:29 INFO - "script_repo_revision": "production", 18:56:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 18:56:29 INFO - "repository": "", 18:56:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 18:56:29 INFO - "buildid": "20151117173015", 18:56:29 INFO - "slavename": "talos-linux64-ix-044", 18:56:29 INFO - "pgo_build": "True", 18:56:29 INFO - "basedir": "/builds/slave/test-pgo", 18:56:29 INFO - "project": "", 18:56:29 INFO - "platform": "ubuntu64_hw", 18:56:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:56:29 INFO - "slavebuilddir": "test", 18:56:29 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 18:56:29 INFO - "branch": "fx-team", 18:56:29 INFO - "repo_path": "integration/fx-team", 18:56:29 INFO - "stage_platform": "linux64-pgo", 18:56:29 INFO - "builduid": "012ecbf6ee8c498ebaf4cf1692b614a7", 18:56:29 INFO - "revision": "8e712e56faf8ef12537ad604f38bca4f06665a7b" 18:56:29 INFO - }, 18:56:29 INFO - "sourcestamp": { 18:56:29 INFO - "repository": "", 18:56:29 INFO - "hasPatch": false, 18:56:29 INFO - "project": "", 18:56:29 INFO - "branch": "fx-team-linux64-pgo-talos", 18:56:29 INFO - "changes": [ 18:56:29 INFO - { 18:56:29 INFO - "category": null, 18:56:29 INFO - "files": [ 18:56:29 INFO - { 18:56:29 INFO - "url": null, 18:56:29 INFO - "name": "https://queue.taskcluster.net/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 18:56:29 INFO - } 18:56:29 INFO - ], 18:56:29 INFO - "repository": "", 18:56:29 INFO - "rev": "8e712e56faf8ef12537ad604f38bca4f06665a7b", 18:56:29 INFO - "who": "sendchange", 18:56:29 INFO - "when": 1447815318, 18:56:29 INFO - "number": 6675607, 18:56:29 INFO - "comments": "", 18:56:29 INFO - "project": "", 18:56:29 INFO - "at": "Tue 17 Nov 2015 18:55:18", 18:56:29 INFO - "branch": "fx-team-linux64-pgo-talos", 18:56:29 INFO - "revlink": "", 18:56:29 INFO - "properties": [ 18:56:29 INFO - [ 18:56:29 INFO - "buildid", 18:56:29 INFO - "20151117173015", 18:56:29 INFO - "Change" 18:56:29 INFO - ], 18:56:29 INFO - [ 18:56:29 INFO - "builduid", 18:56:29 INFO - "012ecbf6ee8c498ebaf4cf1692b614a7", 18:56:29 INFO - "Change" 18:56:29 INFO - ], 18:56:29 INFO - [ 18:56:29 INFO - "pgo_build", 18:56:29 INFO - "True", 18:56:29 INFO - "Change" 18:56:29 INFO - ] 18:56:29 INFO - ], 18:56:29 INFO - "revision": "8e712e56faf8ef12537ad604f38bca4f06665a7b" 18:56:29 INFO - } 18:56:29 INFO - ], 18:56:29 INFO - "revision": "8e712e56faf8ef12537ad604f38bca4f06665a7b" 18:56:29 INFO - } 18:56:29 INFO - } 18:56:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 18:56:29 INFO - Running post-action listener: _resource_record_post_action 18:56:29 INFO - ##### 18:56:29 INFO - ##### Running download-and-extract step. 18:56:29 INFO - ##### 18:56:29 INFO - Running pre-action listener: _resource_record_pre_action 18:56:29 INFO - Running main action method: download_and_extract 18:56:29 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:29 INFO - https://queue.taskcluster.net/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:56:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/test_packages.json 18:56:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/test_packages.json 18:56:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 18:56:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 18:56:35 INFO - Downloaded 1302 bytes. 18:56:35 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 18:56:35 INFO - Using the following test package requirements: 18:56:35 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:56:35 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:56:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:56:35 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:56:35 INFO - u'jsshell-linux-x86_64.zip'], 18:56:35 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:56:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:56:35 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:56:35 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:56:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:56:35 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:56:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:56:35 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:56:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:56:35 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:56:35 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:56:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:56:35 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:56: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')]} 18:56:35 INFO - https://queue.taskcluster.net/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:56:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:56:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:56:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/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 18:56:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/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 18:56:36 INFO - Downloaded 22461291 bytes. 18:56:36 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 18:56:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:56:36 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 18:56:37 INFO - Return code: 0 18:56:37 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 18:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:37 INFO - https://queue.taskcluster.net/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:56:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:56:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:56:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/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 18:56:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/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 18:56:40 INFO - Downloaded 22461291 bytes. 18:56:40 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 18:56:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:56:40 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 18:56:41 INFO - Return code: 0 18:56:41 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')]} 18:56:41 INFO - https://queue.taskcluster.net/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:56:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:56:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:56:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/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 18:56:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/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 18:56:42 INFO - Downloaded 11131693 bytes. 18:56:42 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 18:56:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:56:42 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 18:56:42 INFO - Return code: 0 18:56: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')]} 18:56:42 INFO - https://queue.taskcluster.net/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:56:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:56:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:56:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/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 18:56:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nX3YYY2xQDeU6ir8qOW_zg/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 18:56:44 INFO - Downloaded 57195352 bytes. 18:56:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:56:44 INFO - mkdir: /builds/slave/test-pgo/properties 18:56:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:56:44 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:56:44 INFO - Contents: 18:56:44 INFO - build_url:https://queue.taskcluster.net/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:56:44 INFO - Running post-action listener: _resource_record_post_action 18:56:44 INFO - Running post-action listener: set_extra_try_arguments 18:56:44 INFO - ##### 18:56:44 INFO - ##### Running populate-webroot step. 18:56:44 INFO - ##### 18:56:44 INFO - Running pre-action listener: _resource_record_pre_action 18:56:44 INFO - Running main action method: populate_webroot 18:56:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:56:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:56:44 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:56:44 INFO - '../fennec_ids.txt'], 18:56:44 INFO - 'tests': ['tcheck2']}, 18:56:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:56:44 INFO - '--tppagecycles', 18:56:44 INFO - '7'], 18:56:44 INFO - 'tests': ['tsvgm']}}, 18:56:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:56:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:56:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:56:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:56:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:56:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:56:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:56:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:56:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:56:44 INFO - 'talos_options': ['--e10s'], 18:56:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:56:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:56:44 INFO - 'tests': ['damp', 'tps']}, 18:56:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:56:44 INFO - 'talos_options': ['--e10s'], 18:56:44 INFO - 'tests': ['damp', 'tps']}, 18:56:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:56:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:56:44 INFO - 'other': {'tests': ['a11yr', 18:56:44 INFO - 'ts_paint', 18:56:44 INFO - 'tpaint', 18:56:44 INFO - 'sessionrestore', 18:56:44 INFO - 'sessionrestore_no_auto_restore']}, 18:56:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:56:44 INFO - 'tests': ['a11yr', 18:56:44 INFO - 'ts_paint', 18:56:44 INFO - 'tpaint', 18:56:44 INFO - 'sessionrestore', 18:56:44 INFO - 'sessionrestore_no_auto_restore']}, 18:56:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:56:44 INFO - 'tests': ['a11yr', 18:56:44 INFO - 'ts_paint', 18:56:44 INFO - 'tpaint', 18:56:44 INFO - 'sessionrestore', 18:56:44 INFO - 'sessionrestore_no_auto_restore']}, 18:56:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:56:44 INFO - 'tests': ['a11yr', 18:56:44 INFO - 'ts_paint', 18:56:44 INFO - 'tpaint', 18:56:44 INFO - 'sessionrestore', 18:56:44 INFO - 'sessionrestore_no_auto_restore']}, 18:56:44 INFO - 'other_l64': {'tests': ['a11yr', 18:56:44 INFO - 'ts_paint', 18:56:44 INFO - 'tpaint', 18:56:44 INFO - 'sessionrestore', 18:56:44 INFO - 'sessionrestore_no_auto_restore']}, 18:56:44 INFO - 'other_nol64': {'tests': ['a11yr', 18:56:44 INFO - 'ts_paint', 18:56:44 INFO - 'tpaint', 18:56:44 INFO - 'sessionrestore', 18:56:44 INFO - 'sessionrestore_no_auto_restore']}, 18:56:44 INFO - 'svgr': {'tests': ['tsvgx', 18:56:44 INFO - 'tsvgr_opacity', 18:56:44 INFO - 'tart', 18:56:44 INFO - 'tscrollx', 18:56:44 INFO - 'cart']}, 18:56:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:56:44 INFO - 'tests': ['tsvgx', 18:56:44 INFO - 'tsvgr_opacity', 18:56:44 INFO - 'tart', 18:56:44 INFO - 'tscrollx', 18:56:44 INFO - 'cart']}, 18:56:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:56:44 INFO - 'tests': ['tp5o']}, 18:56:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:56:44 INFO - 'talos_options': ['--e10s'], 18:56:44 INFO - 'tests': ['tp5o']}, 18:56:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:56:44 INFO - 'talos_options': ['--xperf_path', 18:56:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:56:44 INFO - 'tests': ['tp5n']}, 18:56:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:56:44 INFO - 'talos_options': ['--e10s', 18:56:44 INFO - '--xperf_path', 18:56:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:56:44 INFO - 'tests': ['tp5n']}}, 18:56:44 INFO - 'talos.zip': {'path': '', 18:56:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:56:44 INFO - Running post-action listener: _resource_record_post_action 18:56:44 INFO - ##### 18:56:44 INFO - ##### Running create-virtualenv step. 18:56:44 INFO - ##### 18:56:44 INFO - Running pre-action listener: _resource_record_pre_action 18:56:44 INFO - Running main action method: create_virtualenv 18:56:44 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:56:44 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 18:56:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:56:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:56:44 INFO - Using real prefix '/usr' 18:56:44 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:56:44 INFO - Installing distribute.............................................................................................................................................................................................done. 18:56:46 INFO - Installing pip.................done. 18:56:46 INFO - Return code: 0 18:56:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:56:46 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')]} 18:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:46 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')]} 18:56:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:46 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 0x7f1cca458c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a676c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b286e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5ea90>, '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 0x2bb0f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb12e0>, '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': '0cff312cb257a7829adc5a5d000001df-1447814749.804333-1409711051', '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 18:56:46 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 18:56:46 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 18:56:46 INFO - Using env: {'DISPLAY': ':0', 18:56:46 INFO - 'HOME': '/home/cltbld', 18:56:46 INFO - 'LANG': 'en_US.UTF-8', 18:56:46 INFO - 'LANGUAGE': 'en_US:en', 18:56:46 INFO - 'LOGNAME': 'cltbld', 18:56:46 INFO - 'MAIL': '/var/mail/cltbld', 18:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:46 INFO - 'MOZ_NO_REMOTE': '1', 18:56:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:46 INFO - 'NO_EM_RESTART': '1', 18:56:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:56:46 INFO - 'PWD': '/builds/slave/test-pgo', 18:56:46 INFO - 'SHELL': '/bin/bash', 18:56:46 INFO - 'SHLVL': '1', 18:56:46 INFO - 'TERM': 'linux', 18:56:46 INFO - 'TMOUT': '86400', 18:56:46 INFO - 'USER': 'cltbld', 18:56:46 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1447814749.804333-1409711051', 18:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:46 INFO - '_': '/tools/buildbot/bin/python'} 18:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:47 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 18:56:47 INFO - Cleaning up... 18:56:47 INFO - Return code: 0 18:56:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:56: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')]} 18:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56: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')]} 18:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56: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', '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 0x7f1cca458c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a676c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b286e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5ea90>, '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 0x2bb0f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb12e0>, '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': '0cff312cb257a7829adc5a5d000001df-1447814749.804333-1409711051', '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 18:56: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 18:56: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 psutil>=0.7.1 18:56:47 INFO - Using env: {'DISPLAY': ':0', 18:56:47 INFO - 'HOME': '/home/cltbld', 18:56:47 INFO - 'LANG': 'en_US.UTF-8', 18:56:47 INFO - 'LANGUAGE': 'en_US:en', 18:56:47 INFO - 'LOGNAME': 'cltbld', 18:56:47 INFO - 'MAIL': '/var/mail/cltbld', 18:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:47 INFO - 'MOZ_NO_REMOTE': '1', 18:56:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:47 INFO - 'NO_EM_RESTART': '1', 18:56:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:56:47 INFO - 'PWD': '/builds/slave/test-pgo', 18:56:47 INFO - 'SHELL': '/bin/bash', 18:56:47 INFO - 'SHLVL': '1', 18:56:47 INFO - 'TERM': 'linux', 18:56:47 INFO - 'TMOUT': '86400', 18:56:47 INFO - 'USER': 'cltbld', 18:56:47 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1447814749.804333-1409711051', 18:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:47 INFO - '_': '/tools/buildbot/bin/python'} 18:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:47 INFO - Downloading/unpacking psutil>=0.7.1 18:56: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 18:56: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 18:56: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 18:56: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 18:56: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 18:56: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 18:56:48 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 18:56:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:56:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:56:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:56:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:56:49 INFO - Installing collected packages: psutil 18:56:49 INFO - Running setup.py install for psutil 18:56:49 INFO - building 'psutil._psutil_linux' extension 18:56:49 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 18:56:49 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 18:56:49 INFO - building 'psutil._psutil_posix' extension 18:56:49 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 18:56:49 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 18:56:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:56:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:56:49 INFO - Successfully installed psutil 18:56:49 INFO - Cleaning up... 18:56:49 INFO - Return code: 0 18:56:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1cca458c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a676c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b286e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5ea90>, '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 0x2bb0f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb12e0>, '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': '0cff312cb257a7829adc5a5d000001df-1447814749.804333-1409711051', '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 18:56:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 18:56:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:56:49 INFO - Using env: {'DISPLAY': ':0', 18:56:49 INFO - 'HOME': '/home/cltbld', 18:56:49 INFO - 'LANG': 'en_US.UTF-8', 18:56:49 INFO - 'LANGUAGE': 'en_US:en', 18:56:49 INFO - 'LOGNAME': 'cltbld', 18:56:49 INFO - 'MAIL': '/var/mail/cltbld', 18:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:49 INFO - 'MOZ_NO_REMOTE': '1', 18:56:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:49 INFO - 'NO_EM_RESTART': '1', 18:56:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:56:49 INFO - 'PWD': '/builds/slave/test-pgo', 18:56:49 INFO - 'SHELL': '/bin/bash', 18:56:49 INFO - 'SHLVL': '1', 18:56:49 INFO - 'TERM': 'linux', 18:56:49 INFO - 'TMOUT': '86400', 18:56:49 INFO - 'USER': 'cltbld', 18:56:49 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1447814749.804333-1409711051', 18:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:49 INFO - '_': '/tools/buildbot/bin/python'} 18:56:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:56: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 18:56: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 18:56: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 18:56: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 18:56: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 18:56: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 18:56:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:56:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:56:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:56:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:56:51 INFO - Installing collected packages: mozsystemmonitor 18:56:51 INFO - Running setup.py install for mozsystemmonitor 18:56:51 INFO - Successfully installed mozsystemmonitor 18:56:51 INFO - Cleaning up... 18:56:51 INFO - Return code: 0 18:56:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:56: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')]} 18:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56: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')]} 18:56:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:51 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 0x7f1cca458c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a676c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b286e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5ea90>, '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 0x2bb0f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb12e0>, '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': '0cff312cb257a7829adc5a5d000001df-1447814749.804333-1409711051', '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 18:56:51 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 18:56:51 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 18:56:51 INFO - Using env: {'DISPLAY': ':0', 18:56:51 INFO - 'HOME': '/home/cltbld', 18:56:51 INFO - 'LANG': 'en_US.UTF-8', 18:56:51 INFO - 'LANGUAGE': 'en_US:en', 18:56:51 INFO - 'LOGNAME': 'cltbld', 18:56:51 INFO - 'MAIL': '/var/mail/cltbld', 18:56:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:51 INFO - 'MOZ_NO_REMOTE': '1', 18:56:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:51 INFO - 'NO_EM_RESTART': '1', 18:56:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:56:51 INFO - 'PWD': '/builds/slave/test-pgo', 18:56:51 INFO - 'SHELL': '/bin/bash', 18:56:51 INFO - 'SHLVL': '1', 18:56:51 INFO - 'TERM': 'linux', 18:56:51 INFO - 'TMOUT': '86400', 18:56:51 INFO - 'USER': 'cltbld', 18:56:51 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1447814749.804333-1409711051', 18:56:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:51 INFO - '_': '/tools/buildbot/bin/python'} 18:56:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:51 INFO - Downloading/unpacking blobuploader==1.2.4 18:56:51 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 18:56:51 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 18:56:51 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 18:56:51 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 18:56:51 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 18:56:51 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 18:56:53 INFO - Downloading blobuploader-1.2.4.tar.gz 18:56:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:56:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:56:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:56:53 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 18:56:53 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 18:56:53 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 18:56:53 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 18:56:53 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 18:56:53 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 18:56:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:56:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:56:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:56:53 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 18:56:53 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 18:56:53 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 18:56:53 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 18:56:53 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 18:56:53 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 18:56:54 INFO - Downloading docopt-0.6.1.tar.gz 18:56:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:56:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:56:54 INFO - Installing collected packages: blobuploader, requests, docopt 18:56:54 INFO - Running setup.py install for blobuploader 18:56:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:56:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:56:54 INFO - Running setup.py install for requests 18:56:54 INFO - Running setup.py install for docopt 18:56:54 INFO - Successfully installed blobuploader requests docopt 18:56:54 INFO - Cleaning up... 18:56:54 INFO - Return code: 0 18:56:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:56: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')]} 18:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56: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')]} 18:56:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:54 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 0x7f1cca458c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a676c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b286e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5ea90>, '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 0x2bb0f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb12e0>, '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': '0cff312cb257a7829adc5a5d000001df-1447814749.804333-1409711051', '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 18:56:54 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 18:56:54 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 18:56:54 INFO - Using env: {'DISPLAY': ':0', 18:56:54 INFO - 'HOME': '/home/cltbld', 18:56:54 INFO - 'LANG': 'en_US.UTF-8', 18:56:54 INFO - 'LANGUAGE': 'en_US:en', 18:56:54 INFO - 'LOGNAME': 'cltbld', 18:56:54 INFO - 'MAIL': '/var/mail/cltbld', 18:56:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:54 INFO - 'MOZ_NO_REMOTE': '1', 18:56:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:54 INFO - 'NO_EM_RESTART': '1', 18:56:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:56:54 INFO - 'PWD': '/builds/slave/test-pgo', 18:56:54 INFO - 'SHELL': '/bin/bash', 18:56:54 INFO - 'SHLVL': '1', 18:56:54 INFO - 'TERM': 'linux', 18:56:54 INFO - 'TMOUT': '86400', 18:56:54 INFO - 'USER': 'cltbld', 18:56:54 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1447814749.804333-1409711051', 18:56:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:54 INFO - '_': '/tools/buildbot/bin/python'} 18:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:56:55 INFO - Running setup.py (path:/tmp/pip-M9JAYY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:56:55 INFO - Running setup.py (path:/tmp/pip-xfuvow-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:56:55 INFO - Running setup.py (path:/tmp/pip-bc3xM_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:56:55 INFO - Running setup.py (path:/tmp/pip-AcHvf3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:56:55 INFO - Running setup.py (path:/tmp/pip-mvneSG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:56:55 INFO - Running setup.py (path:/tmp/pip-lSojav-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:56:55 INFO - Running setup.py (path:/tmp/pip-EKqKej-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:56:55 INFO - Running setup.py (path:/tmp/pip-1ljAp7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:56:55 INFO - Running setup.py (path:/tmp/pip-wfkzF5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:56:55 INFO - Running setup.py (path:/tmp/pip-OUYVNl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:56:55 INFO - Running setup.py (path:/tmp/pip-x_l8Mq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:56:55 INFO - Running setup.py (path:/tmp/pip-Nw_48T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:56:55 INFO - Running setup.py (path:/tmp/pip-XoTLaZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:56:55 INFO - Running setup.py (path:/tmp/pip-8V61In-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:56:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:56:56 INFO - Running setup.py (path:/tmp/pip-VBBH0i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:56:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:56:56 INFO - Running setup.py (path:/tmp/pip-Cbjquj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:56:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:56:56 INFO - Running setup.py (path:/tmp/pip-cXdt7E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:56:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:56:56 INFO - Running setup.py install for manifestparser 18:56:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:56:56 INFO - Running setup.py install for mozcrash 18:56:56 INFO - Running setup.py install for mozdebug 18:56:56 INFO - Running setup.py install for mozdevice 18:56:56 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:56:56 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:56:56 INFO - Running setup.py install for mozfile 18:56:56 INFO - Running setup.py install for mozhttpd 18:56:56 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:56:56 INFO - Running setup.py install for mozinfo 18:56:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:56:56 INFO - Running setup.py install for mozInstall 18:56:57 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:56:57 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:56:57 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:56:57 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:56:57 INFO - Running setup.py install for mozleak 18:56:57 INFO - Running setup.py install for mozlog 18:56:57 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:56:57 INFO - Running setup.py install for moznetwork 18:56:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:56:57 INFO - Running setup.py install for mozprocess 18:56:57 INFO - Running setup.py install for mozprofile 18:56:57 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:56:57 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:56:57 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:56:57 INFO - Running setup.py install for mozrunner 18:56:57 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:56:57 INFO - Running setup.py install for mozscreenshot 18:56:57 INFO - Running setup.py install for moztest 18:56:57 INFO - Running setup.py install for mozversion 18:56:58 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:56:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:56:58 INFO - Cleaning up... 18:56:58 INFO - Return code: 0 18:56:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:58 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 0x7f1cca458c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a676c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b286e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5ea90>, '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 0x2bb0f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb12e0>, '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': '0cff312cb257a7829adc5a5d000001df-1447814749.804333-1409711051', '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 18:56:58 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 18:56:58 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 18:56:58 INFO - Using env: {'DISPLAY': ':0', 18:56:58 INFO - 'HOME': '/home/cltbld', 18:56:58 INFO - 'LANG': 'en_US.UTF-8', 18:56:58 INFO - 'LANGUAGE': 'en_US:en', 18:56:58 INFO - 'LOGNAME': 'cltbld', 18:56:58 INFO - 'MAIL': '/var/mail/cltbld', 18:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:58 INFO - 'MOZ_NO_REMOTE': '1', 18:56:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:58 INFO - 'NO_EM_RESTART': '1', 18:56:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:56:58 INFO - 'PWD': '/builds/slave/test-pgo', 18:56:58 INFO - 'SHELL': '/bin/bash', 18:56:58 INFO - 'SHLVL': '1', 18:56:58 INFO - 'TERM': 'linux', 18:56:58 INFO - 'TMOUT': '86400', 18:56:58 INFO - 'USER': 'cltbld', 18:56:58 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1447814749.804333-1409711051', 18:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:58 INFO - '_': '/tools/buildbot/bin/python'} 18:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:56:58 INFO - Running setup.py (path:/tmp/pip-GlDA2B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:56:58 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)) 18:56:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:56:58 INFO - Running setup.py (path:/tmp/pip-EP_8Yg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:56:58 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)) 18:56:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:56:58 INFO - Running setup.py (path:/tmp/pip-OqTKDh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:56:58 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)) 18:56:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:56:58 INFO - Running setup.py (path:/tmp/pip-iSp1eV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:56:58 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)) 18:56:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:56:58 INFO - Running setup.py (path:/tmp/pip-rEUfSW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:56:58 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)) 18:56:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:56:58 INFO - Running setup.py (path:/tmp/pip-0fyUP7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:56:58 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)) 18:56:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:56:58 INFO - Running setup.py (path:/tmp/pip-onfiJj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:56:58 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)) 18:56:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:56:58 INFO - Running setup.py (path:/tmp/pip-75x9sR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:56:58 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)) 18:56:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:56:58 INFO - Running setup.py (path:/tmp/pip-ZS7x3I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:56:58 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)) 18:56:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:56:58 INFO - Running setup.py (path:/tmp/pip-V15nwA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:56:59 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)) 18:56:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:56:59 INFO - Running setup.py (path:/tmp/pip-qXnR6T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:56:59 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)) 18:56:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:56:59 INFO - Running setup.py (path:/tmp/pip-xhrOSy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:56:59 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)) 18:56:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:56:59 INFO - Running setup.py (path:/tmp/pip-bRNVNc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:56:59 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)) 18:56:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:56:59 INFO - Running setup.py (path:/tmp/pip-Ps453M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:56:59 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)) 18:56:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:56:59 INFO - Running setup.py (path:/tmp/pip-rjVFYi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:56:59 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)) 18:56:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:56:59 INFO - Running setup.py (path:/tmp/pip-1olGsz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:56:59 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)) 18:56:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:56:59 INFO - Running setup.py (path:/tmp/pip-Stg5hy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:56:59 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)) 18:56:59 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)) 18:56:59 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)) 18:56:59 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)) 18:56:59 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)) 18:56:59 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)) 18:56:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:56:59 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 18:56:59 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 18:56:59 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 18:56:59 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 18:56:59 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 18:56:59 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 18:57:01 INFO - Downloading blessings-1.5.1.tar.gz 18:57:01 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 18:57:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:57:01 INFO - Installing collected packages: blessings 18:57:01 INFO - Running setup.py install for blessings 18:57:01 INFO - Successfully installed blessings 18:57:01 INFO - Cleaning up... 18:57:01 INFO - Return code: 0 18:57:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:57:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:57:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:57:01 INFO - Reading from file tmpfile_stdout 18:57:01 INFO - Current package versions: 18:57:01 INFO - argparse == 1.2.1 18:57:01 INFO - blessings == 1.5.1 18:57:01 INFO - blobuploader == 1.2.4 18:57:01 INFO - docopt == 0.6.1 18:57:01 INFO - manifestparser == 1.1 18:57:01 INFO - mozInstall == 1.12 18:57:01 INFO - mozcrash == 0.16 18:57:01 INFO - mozdebug == 0.1 18:57:01 INFO - mozdevice == 0.47 18:57:01 INFO - mozfile == 1.2 18:57:01 INFO - mozhttpd == 0.7 18:57:01 INFO - mozinfo == 0.9 18:57:01 INFO - mozleak == 0.1 18:57:01 INFO - mozlog == 3.0 18:57:01 INFO - moznetwork == 0.27 18:57:01 INFO - mozprocess == 0.22 18:57:01 INFO - mozprofile == 0.27 18:57:01 INFO - mozrunner == 6.11 18:57:01 INFO - mozscreenshot == 0.1 18:57:01 INFO - mozsystemmonitor == 0.0 18:57:01 INFO - moztest == 0.7 18:57:01 INFO - mozversion == 1.4 18:57:01 INFO - psutil == 3.1.1 18:57:01 INFO - requests == 1.2.3 18:57:01 INFO - wsgiref == 0.1.2 18:57:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:01 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 0x7f1cca458c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a676c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b286e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5ea90>, '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 0x2bb0f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb12e0>, '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': '0cff312cb257a7829adc5a5d000001df-1447814749.804333-1409711051', '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 18:57:01 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 18:57:01 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 18:57:01 INFO - Using env: {'DISPLAY': ':0', 18:57:01 INFO - 'HOME': '/home/cltbld', 18:57:01 INFO - 'LANG': 'en_US.UTF-8', 18:57:01 INFO - 'LANGUAGE': 'en_US:en', 18:57:01 INFO - 'LOGNAME': 'cltbld', 18:57:01 INFO - 'MAIL': '/var/mail/cltbld', 18:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:01 INFO - 'MOZ_NO_REMOTE': '1', 18:57:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:01 INFO - 'NO_EM_RESTART': '1', 18:57:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:57:01 INFO - 'PWD': '/builds/slave/test-pgo', 18:57:01 INFO - 'SHELL': '/bin/bash', 18:57:01 INFO - 'SHLVL': '1', 18:57:01 INFO - 'TERM': 'linux', 18:57:01 INFO - 'TMOUT': '86400', 18:57:01 INFO - 'USER': 'cltbld', 18:57:01 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1447814749.804333-1409711051', 18:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:01 INFO - '_': '/tools/buildbot/bin/python'} 18:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:01 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)) 18:57:01 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)) 18:57:01 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)) 18:57:01 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)) 18:57:01 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)) 18:57:01 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)) 18:57:01 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)) 18:57:01 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)) 18:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 18:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 18:57:01 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)) 18:57:01 INFO - Cleaning up... 18:57:01 INFO - Return code: 0 18:57:01 INFO - Running post-action listener: _resource_record_post_action 18:57:01 INFO - Running post-action listener: _start_resource_monitoring 18:57:01 INFO - Starting resource monitoring. 18:57:01 INFO - ##### 18:57:01 INFO - ##### Running install step. 18:57:01 INFO - ##### 18:57:01 INFO - Running pre-action listener: _resource_record_pre_action 18:57:01 INFO - Running main action method: install 18:57:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:57:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:57:02 INFO - Reading from file tmpfile_stdout 18:57:02 INFO - Detecting whether we're running mozinstall >=1.0... 18:57:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:57:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:57:02 INFO - Reading from file tmpfile_stdout 18:57:02 INFO - Output received: 18:57:02 INFO - Usage: mozinstall [options] installer 18:57:02 INFO - Options: 18:57:02 INFO - -h, --help show this help message and exit 18:57:02 INFO - -d DEST, --destination=DEST 18:57:02 INFO - Directory to install application into. [default: 18:57:02 INFO - "/builds/slave/test-pgo"] 18:57:02 INFO - --app=APP Application being installed. [default: firefox] 18:57:02 INFO - mkdir: /builds/slave/test-pgo/build/application 18:57:02 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'] 18:57:02 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 18:57:16 INFO - Reading from file tmpfile_stdout 18:57:16 INFO - Output received: 18:57:16 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:57:16 INFO - Running post-action listener: _resource_record_post_action 18:57:16 INFO - ##### 18:57:16 INFO - ##### Running run-tests step. 18:57:16 INFO - ##### 18:57:16 INFO - Running pre-action listener: _resource_record_pre_action 18:57:16 INFO - Running main action method: run_tests 18:57:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:57:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:57:16 INFO - Python 2.7.3 18:57:16 INFO - Return code: 0 18:57:16 INFO - grabbing minidump binary from tooltool 18:57:16 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')]} 18:57:16 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 0x2b5ea90>, '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 0x2bb0f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb12e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:57:16 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 18:57:16 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 18:57:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:57:16 INFO - Return code: 0 18:57:16 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:57:16 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:57:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:57:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:57:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:57:16 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 18:57:16 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --webServer localhost 18:57:16 INFO - Using env: {'DISPLAY': ':0', 18:57:16 INFO - 'HOME': '/home/cltbld', 18:57:16 INFO - 'LANG': 'en_US.UTF-8', 18:57:16 INFO - 'LANGUAGE': 'en_US:en', 18:57:16 INFO - 'LOGNAME': 'cltbld', 18:57:16 INFO - 'MAIL': '/var/mail/cltbld', 18:57:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:57:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:16 INFO - 'MOZ_NO_REMOTE': '1', 18:57:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:57:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:16 INFO - 'NO_EM_RESTART': '1', 18:57:16 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:57:16 INFO - 'PWD': '/builds/slave/test-pgo', 18:57:16 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:57:16 INFO - 'SHELL': '/bin/bash', 18:57:16 INFO - 'SHLVL': '1', 18:57:16 INFO - 'TERM': 'linux', 18:57:16 INFO - 'TMOUT': '86400', 18:57:16 INFO - 'USER': 'cltbld', 18:57:16 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1447814749.804333-1409711051', 18:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:16 INFO - '_': '/tools/buildbot/bin/python'} 18:57:16 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost'] with output_timeout 3600 18:57:16 INFO - mozversion INFO | application_buildid: 20151117173015 18:57:16 INFO - mozversion INFO | application_changeset: 8e712e56faf8ef12537ad604f38bca4f06665a7b 18:57:16 INFO - mozversion INFO | application_display_name: Nightly 18:57:16 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:57:16 INFO - mozversion INFO | application_name: Firefox 18:57:16 INFO - mozversion INFO | application_remotingname: firefox 18:57:16 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 18:57:16 INFO - mozversion INFO | application_vendor: Mozilla 18:57:16 INFO - mozversion INFO | application_version: 45.0a1 18:57:16 INFO - mozversion INFO | platform_buildid: 20151117173015 18:57:16 INFO - mozversion INFO | platform_changeset: 8e712e56faf8ef12537ad604f38bca4f06665a7b 18:57:16 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 18:57:16 INFO - mozversion INFO | platform_version: 45.0a1 18:57:16 INFO - 2015-11-17 18:57:16,756 DEBUG : using testdate: 1447815436 18:57:16 INFO - 2015-11-17 18:57:16,757 DEBUG : actual date: 1447815436 18:57:16 INFO - 2015-11-17 18:57:16,769 INFO : starting webserver on 'localhost:60395' 18:57:16 INFO - 2015-11-17 18:57:16,770 INFO : Starting test suite talos-linux64-ix-044.e 18:57:16 INFO - 2015-11-17 18:57:16,770 INFO : Starting test dromaeo_css 18:57:16 INFO - 2015-11-17 18:57:16,770 DEBUG : operating with platform_type : linux_ 18:57:16 INFO - 2015-11-17 18:57:16,771 INFO : Initialising browser for dromaeo_css test... 18:57:16 INFO - 2015-11-17 18:57:16,786 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkTO87M/profile http://localhost:60395/getInfo.html 18:57:21 INFO - 2015-11-17 18:57:21,973 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:57:21 INFO - 2015-11-17 18:57:21,973 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:57:21 INFO - 2015-11-17 18:57:21,973 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:57:21 INFO - 2015-11-17 18:57:21,974 DEBUG : BROWSER_OUTPUT: __metrics 18:57:23 INFO - 2015-11-17 18:57:23,133 INFO : Browser initialized. 18:57:23 INFO - 2015-11-17 18:57:23,134 INFO : Running cycle 1/1 for dromaeo_css test... 18:57:23 INFO - 2015-11-17 18:57:23,134 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkTO87M/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:57:34 INFO - 2015-11-17 18:57:34,883 DEBUG : BROWSER_OUTPUT: RSS: Main: 141611008 18:57:34 INFO - 2015-11-17 18:57:34,883 DEBUG : BROWSER_OUTPUT: 18:58:24 INFO - 2015-11-17 18:58:24,494 DEBUG : BROWSER_OUTPUT: 1447815504487 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] 19:00:32 INFO - 2015-11-17 19:00:32,953 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60395/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60395/tests/dromaeo/cssquery-ext.html) 19:00:33 INFO - 2015-11-17 19:00:33,923 DEBUG : BROWSER_OUTPUT: RSS: Main: 147009536 19:00:33 INFO - 2015-11-17 19:00:33,923 DEBUG : BROWSER_OUTPUT: 19:03:35 INFO - 2015-11-17 19:03:35,890 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60395/tests/dromaeo/cssquery-ext.html (next: http://localhost:60395/tests/dromaeo/cssquery-jquery.html) 19:03:36 INFO - 2015-11-17 19:03:36,484 DEBUG : BROWSER_OUTPUT: RSS: Main: 141819904 19:03:36 INFO - 2015-11-17 19:03:36,484 DEBUG : BROWSER_OUTPUT: 19:06:38 INFO - 2015-11-17 19:06:38,056 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60395/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60395/tests/dromaeo/cssquery-mootools.html) 19:06:38 INFO - 2015-11-17 19:06:38,642 DEBUG : BROWSER_OUTPUT: RSS: Main: 142053376 19:06:38 INFO - 2015-11-17 19:06:38,642 DEBUG : BROWSER_OUTPUT: 19:09:40 INFO - 2015-11-17 19:09:40,281 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60395/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60395/tests/dromaeo/cssquery-prototype.html) 19:09:40 INFO - 2015-11-17 19:09:40,883 DEBUG : BROWSER_OUTPUT: RSS: Main: 140869632 19:09:40 INFO - 2015-11-17 19:09:40,883 DEBUG : BROWSER_OUTPUT: 19:12:43 INFO - 2015-11-17 19:12:43,234 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60395/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60395/tests/dromaeo/cssquery-yui.html) 19:12:43 INFO - 2015-11-17 19:12:43,816 DEBUG : BROWSER_OUTPUT: RSS: Main: 141017088 19:12:43 INFO - 2015-11-17 19:12:43,816 DEBUG : BROWSER_OUTPUT: 19:15:46 INFO - 2015-11-17 19:15:46,145 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60395/tests/dromaeo/cssquery-yui.html (next: http://localhost:60395/tests/dromaeo/cssquery-dojo.html) 19:15:46 INFO - 2015-11-17 19:15:46,395 DEBUG : BROWSER_OUTPUT: RSS: Main: 144433152 19:15:46 INFO - 2015-11-17 19:15:46,395 DEBUG : BROWSER_OUTPUT: 19:15:46 INFO - 2015-11-17 19:15:46,397 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:15:46 INFO - 2015-11-17 19:15:46,397 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:15:46 INFO - 2015-11-17 19:15:46,397 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:15:46 INFO - 2015-11-17 19:15:46,397 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:15:46 INFO - 2015-11-17 19:15:46,401 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3182.061291918884;3229.2572708277094;3253.772235943482;3272.018394481655;3277.9016629501125;5207.765650545725;5337.092694241988;5412.621116521845;5471.50756431921;5474.178873169021;5201.843944681666;5285.392179899312;5316.574674026078;5332.14685650296;5342.839714808552;4909.631777616675;5003.624728145385;5086.3387759591205;5115.079285728568;5155.510226528474;4876.561109500144;4941.308216849626;4972.875678108058;4988.875278118058;5022.17134172861;4789.928151077736;4863.732494712789;4870.099031679115;4998.775055122528;5014.448410674823;4913.901721965541;4914.238293064581;4939.110960027194;4958.553730164266;4971.279164521125;4893.290472881412;4908.754562271872;4915.827946021872;4924.778384972685;4977.1538838397555;5240.475952404767;5246.658967167122;5295.4969277918535;5299.33758280215;5354.464553544653;5865.178874957509;5891;5899.144624029492;5899.262592175978;5910;5768.3654797972185;5858.502027327682;5897.292324921037;5915.142304365886;5942.3760505146765;5258.710770907599;5359.464053594609;5359.973200133974;5360.6247562671015;5423.538999185074;5959.821205363846;5979.820605381846;5980.910286345708;5990.041593345044;6002.789902353396;5609.5792815539;5712.200291959129;5721;5778.046622307273;5783.103618939072;5938.970305148533;5955.970220148958;5965;5966.31387390447;5983.1623572699855;5855.707214639251;5863.970680146657;5903.527717782567;5911.704414779244;5928.229330187134;5711.086226203871;5832.212651292106;5837.9124313135335;5935.881282374328;6001.699915004232;4570.88572785683;4571.611413029929;4582.060677561092;4588.082383523309;4621.768911554409;4066.044479547304;4078;4091.4067460218102;4098.057446787256;4114.177164567099;5390.51485366311;5442.319710036246;5515.696636684941;5569.972150139304;5580.1629755537;5881.382454842265;5889.823305300848;5900.763969441175;5940.108983652401;5947.316058653224;5458.399576046631;5578.776848926079;5597.63615365;5609.1305847593685;5633.802816901471;4981.90036199274;4990.575801056878;4994.575461085776;5040.319556859777;5165.638405311592;6033.637981721111;6089.8477538061015;6092;6093.8476538086015;6097.817065488042;5875.148103524965;5882.411758824083;5903.527717782481;5909.409059094056;5910.261217347832;5842.795502157404;5905.940940590539;5962.642241465526;5997.13041608973;6103.450689437972;5653.3216014076925;5795.536357091339;5818.679972601548;5828.271466066742;5832.854178645568;5775.335836378702;5872.677002764889;5904.409559044061;5942.405759424023;5947.137665038459;5667.291588551431;5669.149627555735;5771.076627739541;5851.356350801493;5913.586048976703;5673.234113394639;5782.190493330853;5784.768609255582;5785;5798.391168927202;5530.419305972976;5623.662580245198;5670;5704.258446402107;5713.371529131875;5677.77288908439;5803.9419605803405;5837.795677151279;5839.211706419579;5841.036229022164;5623.971880140573;5651.858703532444;5660.745266463102;5673.517750991047;5674.347450043298 19:15:46 INFO - 2015-11-17 19:15:46,401 DEBUG : BROWSER_OUTPUT: |1;ext.html;559.8768270980386;591.5179129009857;602.5571205164204;607.0681503891526;607.0954278125594;30497.542536861936;40154.397684034724;40233.798831005806;40259;40381.3942790858;43125.137497250114;43146.78426607871;43273;43390.56609433905;43494.7825260874;8747.693830715942;8798.86801697975;8875.423097498642;8900.19898209161;8922.776930576754;8681.782955426102;8755.56222188888;8812.295016398704;8830.161134692225;8846.778830529223;8672.653093876237;8680.392372533925;8711.825763484727;8722.433041852259;8737.126287371275;8788.69239576615;8861.778455538599;8863.822723545525;8867.423617464909;8872.955635221848;8669.609867555975;8763.78090547735;8776.868346974801;8817.338699597492;8823.69117080899;39840.20319593621;40207.396889046686;40330.193396131916;40454.393184102264;40480;3201.375731732313;3237.7733558650903;3293.736501079908;3573.3746594345885;3640.2537479816574;29507.409851802844;29846.552301715492;29950.400991980256;30102.84948575265;30851.845740771376;3380.3746306933294;3412.8293585320635;3428.9314213715834;3535.328287625343;3551.94672079919;259815;261670.9999999981;262603;262651;263249;41536.37695434571;41930;41976.790116049226;42200;42271.57728422738;39792.801035994635;39793.80103099466;39927.600723992386;40078;40116.398254026215;13485.056046076877;13551.932240338736;13558.186508809504;13570.728585428433;13572.728545429036;10504.107150892107;10523.789524209626;10556.788864222672;10654.254202205771;10835.83746243807;12393.938030309972;12425.19236249641;12462.189957652723;12489.625311240678;12562.748745025048;5702.173184888168;5781.277340332458;5828.970855145697;5833.183354330397;5861.531077513789;895.5029958373166;999.9050090241416;1059.7085801404676;1117.804384232756;1141.4806263150247;28236.71763282382;28270.434591308058;28463.857680711877;28648;32384.83807580947;1012.8655905386015;1031.3090229546071;1045.8901815309434;1095.8739744929435;1127.115214556569;16813.243404046847;17002.404915827887;17265.223064961854;17290.567735806453;17327.2202750874;406605;408301;411037;411443;413098;55006.44993550093;55083;55349.169762453595;55376.44623553794;55396.446035539935;1325.6619562011626;1328.9800652990214;1344.3681469709024;1353.289523000413;1356.4641966423208;28966;30405.543916840823;31331;32403;32580.102527241674;49466.75266623644;50002.249966251264;50021.749891250314;50145.74927125341;50283.24575131303;305356;308720;308830;308859;309536;41664.58335416607;42012.159756805304;45640.771796140805;46192.30711539262;46733.2990005157;43286.56713432825;43743.78128109339;43960.12079758323;44082;44226.33660495031;36628.81685591555;36912;37534.249315014094;38047.61952380441;38382.424263636625;36509.45235821518;36968.26063478769;37081.62918370782;37391.6260837399;40304.59695403009;35995;36434;36467.27065458623;36482.452763209105;36589.26821463609;31789.523157152198;32869.34261314808;34042.82978585091;34048.14879628029;34309.48535772015;25635.871820640776;25647.358816029748;25655;25794.8710256455;25823 19:15:46 INFO - 2015-11-17 19:15:46,404 DEBUG : BROWSER_OUTPUT: |2;jquery.html;356.8037579331367;356.99286014279716;358.82238292045434;361.30268581637444;361.7377401383997;14584.979051466402;14661.193634350106;15718.764218536731;16258.268377922992;17131.400400985982;16578.83421165788;16634.75047874283;16703.83296167038;17036.063016534084;17054.914725426388;5512.310961129859;5620.381758006616;5667.121596152582;5668.943310566903;5679.602427830054;5522.502974732273;5600.18797274395;5633.380328163898;5659.971700141494;5664.065429204197;5566.526845218162;5601.411851755568;5601.60788744786;5607.383187849333;5608.411116832735;4958.504149585049;5578.079616863212;5588.21764952907;5594.468525490072;5594.916076258839;4362;4372.060007098489;4374;4382.452193475816;4384.649228061748;13717.519886803913;13802.65493362664;13862.306884655727;13888.4444622215;13927.442902283896;1993.1130646862152;2049.0574335805545;2058.464799152216;2061.4846288427893;2072.243631074662;10105.191584673208;10122.190224782;10199.949000255025;10250.897491025069;10314.638987635397;1684.6378028723884;1706.5562953632145;1712.7430885367294;1719.149021234497;1784.2149454240223;59633.40366596322;60279.39720602782;61082.694586526784;61094.389056109314;61270.69364653193;6966.721331146799;7072.5402848814665;7171.354578087893;7210.351068403764;7229.7469588564145;8263.256306932284;8386.161383861565;8422.620982055822;8536.359773017048;8552.529610871337;5435.7825686972865;5439.728013599304;5534.723263836792;5541.501264886179;5555.3611334697025;5588.826346467206;5599.244102046253;5618.438156184349;5658.858528536737;5704.828855134353;3313.7514686398617;3385.830708464567;3395.3888300105723;3413.2490852012515;3415.3852306585054;1186.2822992089834;1191.9642410727693;1192.7674103549725;1193.3854065156452;1213.0538180219444;441.63123791633706;457.4236462057831;467.2220752447137;480;494.35980405375125;11793.174477786644;12020.21868578557;12270.141090123785;12467.563635272722;12495.50017999288;476.49015553358265;478.4378355432353;478.4880178209352;482.09847585016246;494.27341807542854;6519.152510173742;6690.732370705117;6699.732010719516;6716.597004179765;6734.292899245606;563839;564964;566886;569414;574249;78032.21967780363;80242.59878700569;80340.19659803328;80361;80745.59627201826;539.1912131802296;546.0198942897508;546.710243570908;548.0518702644367;549.0638461423264;11326.490307936327;11386.43067846621;11519.654410367702;11651.76696466049;11724.531018759495;34940.82529587336;35406.46890296699;36117;36685.63314366822;37553.81223093867;45097.54902451065;45281.54718452905;45328.640140795826;46114.538854611026;47246;6870.931290687029;7035.964820175866;7038.120234970629;7088.64556772149;7098.787036388917;12288.508459661514;12523.74952500963;12712.555060572835;12741.362931853555;12779.61661150167;10955.56177752881;11033.724156895822;11121.666350009513;11125.44372781374;11377.08983281319;10820;10834.295770774874;10946.671599852018;11050.226484146033;11234.662960111209;11094.667159985212;11424.82862757076;11447.740748517823;11506.884931150917;11554.364509952033;6895.896561551681;6988.685509151998;6995.090638217;7033.261507541634;7036.472264580279;10786;11159.442027898735;11180.105591552494;11298.322100673986;11396 19:15:46 INFO - 2015-11-17 19:15:46,405 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1504.9991755482604;1664.3259479910637;1724.4654157211266;1734.85253753431;1754.7981982072065;7114.608696521689;7291.5989620570845;7375.741849035285;7414.1473730521;7579.696812127509;7759.534427934328;7764;7817.061952565686;7819.139894611588;7871.173526779691;2288.7253529576433;2333.288347054148;2336.4158960259933;2339.63735620979;2345.636426353918;2299.287220961499;2318.8724620145886;2333.4982978659586;2335.241046659834;2337.345543247893;2237.865728056314;2256.909723611054;2280.1677387753434;2285.6342985122383;2309.5265470578493;2238.932832015042;2261.7851304126166;2273.59075366434;2275.8862056897256;2277.4078739527677;2243.181238847825;2312.190733243368;2314.2131675230335;2316.3861576682193;2318.258157389636;7629.2752188542;7701.768946931601;7736.149023607399;7749.186335434754;7761.573113478757;4517.006258623131;4562.178807814592;4620.745858977755;4623.2371658676275;4625.699329543569;3071.4778487656927;3102.395032968572;3111.859966301522;3146.7797254192214;3149.653538110806;962.1052421248237;963.0658261486348;976.5800705696547;992.7666998255404;1030.4384110659707;10383.169346452265;10394.63618773347;10413.687589372332;10480.68557943263;10491.58033678652;4011.0574015106426;4087.836486540505;4137.793110344471;4139.710220284612;4145.91708165835;8446.155384461628;8463.53450560225;8466.06873243955;8477;8530.744077677555;4570.720198344469;4572.51988541205;4575.519570445055;4594.563516465931;4612.192866248393;4200.306949353384;4202.684798640114;4209.2423363794815;4211.241976444269;4218.409422680827;3466.9826650866585;3489.8778542750883;3491.1097670093964;3494.8427320770625;3499.9825000874835;1063.7393838509615;1066.3069005146717;1072.7747173093583;1077.52050337599;1083.21466936472;1081.2701426537212;1085.2077983072402;1134.115389995788;1239.8078297863844;1290.1162703547911;7219.422446204291;7245.818854528574;7247.057882475245;7254.056972593529;7289.708411663474;1130.5929865248668;1132.5243397772956;1144.2447984330302;1150.7238262816863;1155.5955415604471;5639.266895303666;5784.797532086357;5798.6810725410505;5805.970970145122;5841.474267315962;8860.512671802984;8902.198802107841;9018.729438116867;9036.32227582934;9124.406913550598;9063.501507417024;9116.042815504408;9127.497987610745;9139.543022848831;9152.95423522878;6993.685284162225;7052.576845389191;7137.785866424016;7138.9286107139305;7174;6896.517243792886;6906.827329316808;6946.479014073863;6948.583085014915;6951.44388448933;7576.356009739234;7776.92223077762;7816.960915195387;7917.604119793872;7972.681092756225;7945.960270198612;8007.719729809429;8151.225633564802;8180.67277308901;8330.458520196167;6831.419329357061;6847.691853866489;6858.794236172923;6943.618101004493;6962.408195303456;7437.851242975218;7445.2182520836695;7454.589997550187;7475.850482990201;7506.474546781673;6913.10129683138;6939.4448444125355;6947.5831450113155;7074.257202993817;7104.964475177591;6354.6822658867795;6476.4495017924;6645.734170633314;6656.933430665631;6849.212340580897;6655.833604159935;6664.633445160563;6685.665716714242;6707.128073350434;6720.059191713066;6146.262448506208;6232.781852635136;6260.405261500332;6372.171617689671;6473.449756770728;6494.285628580947;6534.705938232696;6560.40956313934;6572.047053177167;6586.604803711793 19:15:46 INFO - 2015-11-17 19:15:46,408 DEBUG : BROWSER_OUTPUT: |4;prototype.html;330.2075019952115;339.9762016658833;340.05464807834215;343.2174641816659;349.4810206842838;6335.746570137195;6356.237251529823;6365.554411191219;6390.105385246064;6470.805875823721;6300.149479820223;6369.363063693629;6373.330800265975;6377.6173429594255;6380.1386812780265;4803.135435621587;4809.350737650408;4813.975930120362;4814.181589129839;4816.060868130716;4805.423349198101;4808.735519546423;4812;4822.156122678517;4828.7585620719;4672.486026537078;4745.074710431467;4753.572178503934;4760.047990401933;4761.428628564577;4714.057188562301;4720.315554244649;4720.575148236658;4723.48041715411;4738.786754596052;4082.5509193988637;4096.713230073896;4109.4246805447265;4114.506259248879;4120.134771697947;5921.378255283176;5970.432808883193;5977.46202841742;5983.970080149571;5993.820185394445;5380.2736630555155;5539.14143307788;5548.001359755242;5552.91670624941;5553.333599967989;6639.701213445406;6655.700493477805;6701.899471507932;6708.027336036296;6714.959181326903;4536.34223037661;4553.704009239389;4563.543645635443;4571.040081582872;4578.885527861797;6802.625855577941;6913.481488888354;6957.9304206958295;7033;7050.5546362995465;4650.976745116321;4688.789004494806;4707.811687532529;4712.670113092119;4722.291656251589;4754.595859351924;4771.188897887368;4778.187708089633;4778.593819525309;4780.972091000452;5526.613137080366;5533.446655334515;5537.2524709163745;5537.390887002426;5549.028919939075;6618.470522358296;6804.217514985741;6820.079289295981;6841.692123854438;6850.143732033496;1640.4422496351299;1678.446112782803;1689.1723055702616;1690.0366790929052;1691.8900271482314;1119.171812858479;1126.3242054767074;1127.5961428022165;1128.430142777892;1139.32779660001;6437.742490300429;6441.452476539453;6464.676766161673;6466.612003279818;6470.967645161744;6826.590404575742;6865.588064716033;6882.518223724392;6886.51794374399;6890.414314783199;6382.712777925005;6419.1334169887405;6427.132337134521;6433.906235939901;6451.967740161363;3814.1608846053823;3828.5405751310022;3845.807709614508;3851.2297540492013;3854.094287842355;7309.378702810214;7322.231165727629;7330.376917962033;7348.485606007635;7360.889586656204;7111.608861512666;7215.675294611755;7255.419566434673;7266.237045110293;7275;7290.854182916312;7334.376577990931;7358.300961408658;7368.447366447431;7370.078740157481;6998.545094568837;7037.296270372922;7047.048648432396;7057.929420705727;7063.964680176567;6781.559198652072;6963.373296403348;6987.091678081817;6990.545614535039;7008.859822803617;7304.744333948499;7328.790749526482;7355.374793142642;7364.594947277951;7367.115946086504;4671.019085991844;4695.084458530554;4706.058788242433;4707.129181101507;4710.458297295855;6826.761063362758;6877.4841886857685;7021.332973367522;7077.5399599025895;7079.079719636415;6822;6860.0738900247825;6864.553804002724;6880.621565813928;6901.033855260167;6848.589084654936;6862.725490980504;6869.450443964371;6869.587824730532;6883.65581720922;6571.3100124488155;6677.866442671217;6727.293634168342;6731.754625394122;6752.966235168793;6887.896681549881;6902.689378978059;6908.861822763617;6912.896306555305;6918.792436226921;6711.295313992156;6732.629705366252;6734.764283250259;6735.191776986793;6737.124173857367 19:15:46 INFO - 2015-11-17 19:15:46,412 DEBUG : BROWSER_OUTPUT: |5;yui.html;720.7549433192715;739.3604532079753;811.1401913971188;830.5598033042489;867.496851825941;13706.931465342685;13738;13974.021818472711;13987.160770353787;13996.300184990749;13241.205527668346;14392.352344144512;14394.280285985686;14396.640083997905;14427.927860360709;803.052398170159;809.299955538458;811.3549727966251;819.7827575692446;820.7537738678402;809.8096947217399;812.687115460549;812.7074253268848;815.4129027100478;817.6851912013858;845.5814371885925;850.9021462531795;850.9106543812903;851.059579165023;851.1573542193246;848.2238751542332;848.503625379154;849.8257857139303;852.7271273192581;854.799122206281;617.8115674719209;622.3434276837934;623.4949690750507;623.9937600623981;624.7469774741191;13275.336233188398;13330;13350.599482015556;13371.86628133716;13410.46358145673;10018.448985305806;10463.110635595907;10526.42104684242;10731.195160363004;10742.140628749681;10255;10277.537510812032;10363.896361036368;10364.274500784948;10503.842442363295;3325.617553981299;3335.6831101045364;3338;3343.531905533203;3350.8827191048194;46612.53387466116;46876.765616172044;46969.765151174026;47056.2941555877;47056.76471617654;7510.662020208994;7602.42981776369;7622.809429764189;7755.2632499912415;7872.763817085496;11709.063274937984;11743;11793.764124717458;11795.705107372385;11885.108616853771;6889.552179108342;6915.170179578483;6929.099217101744;7017.824554386079;7069.434445244368;4240.300350442142;4277.508086570022;4288.91422171561;4291.6566674665955;4347.478302603708;2725.986370068137;2726.8636568171514;2746.835189888613;2747.697753247141;2759.0619189475674;424.22578793701;433.0580986354666;433.87200775771225;434.46560730301906;436.6026915506873;505.98229061982653;551.2888373997579;624.8968920128128;664.7133859523225;666.2338310942455;7980.401469889782;7987.349136966506;7997.800054998672;8241.95879020601;8257.628406721711;548.4323724944663;583.8306891001647;595.9970200149058;644.8065580325883;656.3370995294691;3993.5008123984503;4273.722208056529;4276.850310239127;4370.934435983463;4434.068845542408;55092.44907550873;55601;55821.16268255979;55974;59408;50308.245376319384;51399.48600513947;51484;52870.735646321526;53174.734126329124;48284.7585762076;48416.515834841906;48491.75754121278;48741.26888096681;49420.258696119585;8210.137935516685;8259.752207433787;8261.256486916207;8275.917240827515;8458.40791144614;35923.82038089897;36020.63979360173;36383.81808090943;37696.246075078896;37881.81059094687;42942.35586466268;46043.079138417714;46120.15738347425;46435.303470447296;46492;7701.614919253902;7767.456278060482;8027.39794515402;8121.837563248584;8543.487390756574;11927.224730392496;12005.39973001364;12086.093542984136;12373.165597583433;12661.810072849099;10510.369377837354;10580.735481612714;10589.152867770714;11099.667009989713;11167.329960202414;11068.612598559012;11350.886491134983;11364.94317528407;11475.655730328104;11672.416379181177;10686.358818470917;11167.218294719292;11194.104471642411;11196;11439.542418303176;9979.20166386702;10100.24248181404;10248.282620216512;10509.9474502627;10512.894871051192;8367.66529338844;8875.73372798817;8885.733427997171;9307.162355388047;9653.634859459477 19:15:46 INFO - 2015-11-17 19:15:46,412 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:15:46 INFO - 2015-11-17 19:15:46,412 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:15:46 INFO - 2015-11-17 19:15:46,412 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,290 19:15:46 INFO - 2015-11-17 19:15:46,412 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:15:46 INFO - 2015-11-17 19:15:46,413 DEBUG : BROWSER_OUTPUT: __startTimestamp1447816546396__endTimestamp 19:15:46 INFO - 2015-11-17 19:15:46,413 DEBUG : BROWSER_OUTPUT: 19:15:46 INFO - 2015-11-17 19:15:46,413 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:15:46 INFO - 2015-11-17 19:15:46,413 DEBUG : BROWSER_OUTPUT: Number of tests: 6 19:15:46 INFO - 2015-11-17 19:15:46,414 DEBUG : BROWSER_OUTPUT: 19:15:46 INFO - 2015-11-17 19:15:46,414 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5439.15 Median:5667.29 stddev:610.05 (10.8%) stddev-sans-first:585.66 19:15:46 INFO - 2015-11-17 19:15:46,414 DEBUG : BROWSER_OUTPUT: Values: 3182.1 3229.3 3253.8 3272.0 3277.9 5207.8 5337.1 5412.6 5471.5 5474.2 5201.8 5285.4 5316.6 5332.1 5342.8 4909.6 5003.6 5086.3 5115.1 5155.5 4876.6 4941.3 4972.9 4988.9 5022.2 4789.9 4863.7 4870.1 4998.8 5014.4 4913.9 4914.2 4939.1 4958.6 4971.3 4893.3 4908.8 4915.8 4924.8 4977.2 5240.5 5246.7 5295.5 5299.3 5354.5 5865.2 5891.0 5899.1 5899.3 5910.0 5768.4 5858.5 5897.3 5915.1 5942.4 5258.7 5359.5 5360.0 5360.6 5423.5 5959.8 5979.8 5980.9 5990.0 6002.8 5609.6 5712.2 5721.0 5778.0 5783.1 5939.0 5956.0 5965.0 5966.3 5983.2 5855.7 5864.0 5903.5 5911.7 5928.2 5711.1 5832.2 5837.9 5935.9 6001.7 4570.9 4571.6 4582.1 4588.1 4621.8 4066.0 4078.0 4091.4 4098.1 4114.2 5390.5 5442.3 5515.7 5570.0 5580.2 5881.4 5889.8 5900.8 5940.1 5947.3 5458.4 5578.8 5597.6 5609.1 5633.8 4981.9 4990.6 4994.6 5040.3 5165.6 6033.6 6089.8 6092.0 6093.8 6097.8 5875.1 5882.4 5903.5 5909.4 5910.3 5842.8 5905.9 5962.6 5997.1 6103.5 5653.3 5795.5 5818.7 5828.3 5832.9 5775.3 5872.7 5904.4 5942.4 5947.1 5667.3 5669.1 5771.1 5851.4 5913.6 5673.2 5782.2 5784.8 5785.0 5798.4 5530.4 5623.7 5670.0 5704.3 5713.4 5677.8 5803.9 5837.8 5839.2 5841.0 5624.0 5651.9 5660.7 5673.5 5674.3 19:15:46 INFO - 2015-11-17 19:15:46,414 DEBUG : BROWSER_OUTPUT: 19:15:46 INFO - 2015-11-17 19:15:46,414 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48698.59 Median:37790.93 stddev:87504.50 (231.5%) stddev-sans-first:87675.33 19:15:46 INFO - 2015-11-17 19:15:46,415 DEBUG : BROWSER_OUTPUT: Values: 559.9 591.5 602.6 607.1 607.1 30497.5 40154.4 40233.8 40259.0 40381.4 43125.1 43146.8 43273.0 43390.6 43494.8 8747.7 8798.9 8875.4 8900.2 8922.8 8681.8 8755.6 8812.3 8830.2 8846.8 8672.7 8680.4 8711.8 8722.4 8737.1 8788.7 8861.8 8863.8 8867.4 8873.0 8669.6 8763.8 8776.9 8817.3 8823.7 39840.2 40207.4 40330.2 40454.4 40480.0 3201.4 3237.8 3293.7 3573.4 3640.3 29507.4 29846.6 29950.4 30102.8 30851.8 3380.4 3412.8 3428.9 3535.3 3551.9 259815.0 261671.0 262603.0 262651.0 263249.0 41536.4 41930.0 41976.8 42200.0 42271.6 39792.8 39793.8 39927.6 40078.0 40116.4 13485.1 13551.9 13558.2 13570.7 13572.7 10504.1 10523.8 10556.8 10654.3 10835.8 12393.9 12425.2 12462.2 12489.6 12562.7 5702.2 5781.3 5829.0 5833.2 5861.5 895.5 999.9 1059.7 1117.8 1141.5 28236.7 28270.4 28463.9 28648.0 32384.8 1012.9 1031.3 1045.9 1095.9 1127.1 16813.2 17002.4 17265.2 17290.6 17327.2 406605.0 408301.0 411037.0 411443.0 413098.0 55006.4 55083.0 55349.2 55376.4 55396.4 1325.7 1329.0 1344.4 1353.3 1356.5 28966.0 30405.5 31331.0 32403.0 32580.1 49466.8 50002.2 50021.7 50145.7 50283.2 305356.0 308720.0 308830.0 308859.0 309536.0 41664.6 42012.2 45640.8 46192.3 46733.3 43286.6 43743.8 43960.1 44082.0 44226.3 36628.8 36912.0 37534.2 38047.6 38382.4 36509.5 36968.3 37081.6 37391.6 40304.6 35995.0 36434.0 36467.3 36482.5 36589.3 31789.5 32869.3 34042.8 34048.1 34309.5 25635.9 25647.4 25655.0 25794.9 25823.0 19:15:46 INFO - 2015-11-17 19:15:46,415 DEBUG : BROWSER_OUTPUT: 19:15:46 INFO - 2015-11-17 19:15:46,415 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28117.57 Median:22769.59 stddev:93019.61 (408.5%) stddev-sans-first:93257.19 19:15:46 INFO - 2015-11-17 19:15:46,416 DEBUG : BROWSER_OUTPUT: Values: 356.8 357.0 358.8 361.3 361.7 14585.0 14661.2 15718.8 16258.3 17131.4 16578.8 16634.8 16703.8 17036.1 17054.9 5512.3 5620.4 5667.1 5668.9 5679.6 5522.5 5600.2 5633.4 5660.0 5664.1 5566.5 5601.4 5601.6 5607.4 5608.4 4958.5 5578.1 5588.2 5594.5 5594.9 4362.0 4372.1 4374.0 4382.5 4384.6 13717.5 13802.7 13862.3 13888.4 13927.4 1993.1 2049.1 2058.5 2061.5 2072.2 10105.2 10122.2 10199.9 10250.9 10314.6 1684.6 1706.6 1712.7 1719.1 1784.2 59633.4 60279.4 61082.7 61094.4 61270.7 6966.7 7072.5 7171.4 7210.4 7229.7 8263.3 8386.2 8422.6 8536.4 8552.5 5435.8 5439.7 5534.7 5541.5 5555.4 5588.8 5599.2 5618.4 5658.9 5704.8 3313.8 3385.8 3395.4 3413.2 3415.4 1186.3 1192.0 1192.8 1193.4 1213.1 441.6 457.4 467.2 480.0 494.4 11793.2 12020.2 12270.1 12467.6 12495.5 476.5 478.4 478.5 482.1 494.3 6519.2 6690.7 6699.7 6716.6 6734.3 563839.0 564964.0 566886.0 569414.0 574249.0 78032.2 80242.6 80340.2 80361.0 80745.6 539.2 546.0 546.7 548.1 549.1 11326.5 11386.4 11519.7 11651.8 11724.5 34940.8 35406.5 36117.0 36685.6 37553.8 45097.5 45281.5 45328.6 46114.5 47246.0 6870.9 7036.0 7038.1 7088.6 7098.8 12288.5 12523.7 12712.6 12741.4 12779.6 10955.6 11033.7 11121.7 11125.4 11377.1 10820.0 10834.3 10946.7 11050.2 11234.7 11094.7 11424.8 11447.7 11506.9 11554.4 6895.9 6988.7 6995.1 7033.3 7036.5 10786.0 11159.4 11180.1 11298.3 11396.0 19:15:46 INFO - 2015-11-17 19:15:46,416 DEBUG : BROWSER_OUTPUT: 19:15:46 INFO - 2015-11-17 19:15:46,417 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5333.14 Median:6422.81 stddev:2706.62 (42.1%) stddev-sans-first:2698.91 19:15:46 INFO - 2015-11-17 19:15:46,418 DEBUG : BROWSER_OUTPUT: Values: 1505.0 1664.3 1724.5 1734.9 1754.8 7114.6 7291.6 7375.7 7414.1 7579.7 7759.5 7764.0 7817.1 7819.1 7871.2 2288.7 2333.3 2336.4 2339.6 2345.6 2299.3 2318.9 2333.5 2335.2 2337.3 2237.9 2256.9 2280.2 2285.6 2309.5 2238.9 2261.8 2273.6 2275.9 2277.4 2243.2 2312.2 2314.2 2316.4 2318.3 7629.3 7701.8 7736.1 7749.2 7761.6 4517.0 4562.2 4620.7 4623.2 4625.7 3071.5 3102.4 3111.9 3146.8 3149.7 962.1 963.1 976.6 992.8 1030.4 10383.2 10394.6 10413.7 10480.7 10491.6 4011.1 4087.8 4137.8 4139.7 4145.9 8446.2 8463.5 8466.1 8477.0 8530.7 4570.7 4572.5 4575.5 4594.6 4612.2 4200.3 4202.7 4209.2 4211.2 4218.4 3467.0 3489.9 3491.1 3494.8 3500.0 1063.7 1066.3 1072.8 1077.5 1083.2 1081.3 1085.2 1134.1 1239.8 1290.1 7219.4 7245.8 7247.1 7254.1 7289.7 1130.6 1132.5 1144.2 1150.7 1155.6 5639.3 5784.8 5798.7 5806.0 5841.5 8860.5 8902.2 9018.7 9036.3 9124.4 9063.5 9116.0 9127.5 9139.5 9153.0 6993.7 7052.6 7137.8 7138.9 7174.0 6896.5 6906.8 6946.5 6948.6 6951.4 7576.4 7776.9 7817.0 7917.6 7972.7 7946.0 8007.7 8151.2 8180.7 8330.5 6831.4 6847.7 6858.8 6943.6 6962.4 7437.9 7445.2 7454.6 7475.9 7506.5 6913.1 6939.4 6947.6 7074.3 7105.0 6354.7 6476.4 6645.7 6656.9 6849.2 6655.8 6664.6 6685.7 6707.1 6720.1 6146.3 6232.8 6260.4 6372.2 6473.4 6494.3 6534.7 6560.4 6572.0 6586.6 19:15:46 INFO - 2015-11-17 19:15:46,418 DEBUG : BROWSER_OUTPUT: 19:15:46 INFO - 2015-11-17 19:15:46,418 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5642.11 Median:6423.13 stddev:1738.41 (27.1%) stddev-sans-first:1696.95 19:15:46 INFO - 2015-11-17 19:15:46,420 DEBUG : BROWSER_OUTPUT: Values: 330.2 340.0 340.1 343.2 349.5 6335.7 6356.2 6365.6 6390.1 6470.8 6300.1 6369.4 6373.3 6377.6 6380.1 4803.1 4809.4 4814.0 4814.2 4816.1 4805.4 4808.7 4812.0 4822.2 4828.8 4672.5 4745.1 4753.6 4760.0 4761.4 4714.1 4720.3 4720.6 4723.5 4738.8 4082.6 4096.7 4109.4 4114.5 4120.1 5921.4 5970.4 5977.5 5984.0 5993.8 5380.3 5539.1 5548.0 5552.9 5553.3 6639.7 6655.7 6701.9 6708.0 6715.0 4536.3 4553.7 4563.5 4571.0 4578.9 6802.6 6913.5 6957.9 7033.0 7050.6 4651.0 4688.8 4707.8 4712.7 4722.3 4754.6 4771.2 4778.2 4778.6 4781.0 5526.6 5533.4 5537.3 5537.4 5549.0 6618.5 6804.2 6820.1 6841.7 6850.1 1640.4 1678.4 1689.2 1690.0 1691.9 1119.2 1126.3 1127.6 1128.4 1139.3 6437.7 6441.5 6464.7 6466.6 6471.0 6826.6 6865.6 6882.5 6886.5 6890.4 6382.7 6419.1 6427.1 6433.9 6452.0 3814.2 3828.5 3845.8 3851.2 3854.1 7309.4 7322.2 7330.4 7348.5 7360.9 7111.6 7215.7 7255.4 7266.2 7275.0 7290.9 7334.4 7358.3 7368.4 7370.1 6998.5 7037.3 7047.0 7057.9 7064.0 6781.6 6963.4 6987.1 6990.5 7008.9 7304.7 7328.8 7355.4 7364.6 7367.1 4671.0 4695.1 4706.1 4707.1 4710.5 6826.8 6877.5 7021.3 7077.5 7079.1 6822.0 6860.1 6864.6 6880.6 6901.0 6848.6 6862.7 6869.5 6869.6 6883.7 6571.3 6677.9 6727.3 6731.8 6753.0 6887.9 6902.7 6908.9 6912.9 6918.8 6711.3 6732.6 6734.8 6735.2 6737.1 19:15:46 INFO - 2015-11-17 19:15:46,420 DEBUG : BROWSER_OUTPUT: 19:15:46 INFO - 2015-11-17 19:15:46,420 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13475.65 Median:46923.27 stddev:16151.56 (34.4%) stddev-sans-first:16168.47 19:15:46 INFO - 2015-11-17 19:15:46,422 DEBUG : BROWSER_OUTPUT: Values: 720.8 739.4 811.1 830.6 867.5 13706.9 13738.0 13974.0 13987.2 13996.3 13241.2 14392.4 14394.3 14396.6 14427.9 803.1 809.3 811.4 819.8 820.8 809.8 812.7 812.7 815.4 817.7 845.6 850.9 850.9 851.1 851.2 848.2 848.5 849.8 852.7 854.8 617.8 622.3 623.5 624.0 624.7 13275.3 13330.0 13350.6 13371.9 13410.5 10018.4 10463.1 10526.4 10731.2 10742.1 10255.0 10277.5 10363.9 10364.3 10503.8 3325.6 3335.7 3338.0 3343.5 3350.9 46612.5 46876.8 46969.8 47056.3 47056.8 7510.7 7602.4 7622.8 7755.3 7872.8 11709.1 11743.0 11793.8 11795.7 11885.1 6889.6 6915.2 6929.1 7017.8 7069.4 4240.3 4277.5 4288.9 4291.7 4347.5 2726.0 2726.9 2746.8 2747.7 2759.1 424.2 433.1 433.9 434.5 436.6 506.0 551.3 624.9 664.7 666.2 7980.4 7987.3 7997.8 8242.0 8257.6 548.4 583.8 596.0 644.8 656.3 3993.5 4273.7 4276.9 4370.9 4434.1 55092.4 55601.0 55821.2 55974.0 59408.0 50308.2 51399.5 51484.0 52870.7 53174.7 48284.8 48416.5 48491.8 48741.3 49420.3 8210.1 8259.8 8261.3 8275.9 8458.4 35923.8 36020.6 36383.8 37696.2 37881.8 42942.4 46043.1 46120.2 46435.3 46492.0 7701.6 7767.5 8027.4 8121.8 8543.5 11927.2 12005.4 12086.1 12373.2 12661.8 10510.4 10580.7 10589.2 11099.7 11167.3 11068.6 11350.9 11364.9 11475.7 11672.4 10686.4 11167.2 11194.1 11196.0 11439.5 9979.2 10100.2 10248.3 10509.9 10512.9 8367.7 8875.7 8885.7 9307.2 9653.6 19:15:46 INFO - 2015-11-17 19:15:46,422 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:15:46 INFO - 2015-11-17 19:15:46,422 DEBUG : BROWSER_OUTPUT: 19:15:47 INFO - 2015-11-17 19:15:47,098 INFO : Browser exited with error code: 0 19:15:47 INFO - 2015-11-17 19:15:47,116 INFO : Completed test dromaeo_css (00:18:30) 19:15:47 INFO - 2015-11-17 19:15:47,116 INFO : Starting test kraken 19:15:47 INFO - 2015-11-17 19:15:47,116 DEBUG : operating with platform_type : linux_ 19:15:47 INFO - 2015-11-17 19:15:47,117 INFO : Initialising browser for kraken test... 19:15:47 INFO - 2015-11-17 19:15:47,123 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVTG0vZ/profile http://localhost:60395/getInfo.html 19:15:52 INFO - 2015-11-17 19:15:52,059 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:15:52 INFO - 2015-11-17 19:15:52,059 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:15:52 INFO - 2015-11-17 19:15:52,059 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:15:52 INFO - 2015-11-17 19:15:52,059 DEBUG : BROWSER_OUTPUT: __metrics 19:15:53 INFO - 2015-11-17 19:15:53,225 INFO : Browser initialized. 19:15:53 INFO - 2015-11-17 19:15:53,226 INFO : Running cycle 1/1 for kraken test... 19:15:53 INFO - 2015-11-17 19:15:53,226 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVTG0vZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:16:05 INFO - 2015-11-17 19:16:05,044 DEBUG : BROWSER_OUTPUT: RSS: Main: 141631488 19:16:05 INFO - 2015-11-17 19:16:05,044 DEBUG : BROWSER_OUTPUT: 19:16:07 INFO - 2015-11-17 19:16:07,525 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60395/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60395/tests/kraken/driver.html?testName=audio-beat-detection) 19:16:08 INFO - 2015-11-17 19:16:08,134 DEBUG : BROWSER_OUTPUT: RSS: Main: 141656064 19:16:08 INFO - 2015-11-17 19:16:08,134 DEBUG : BROWSER_OUTPUT: 19:16:10 INFO - 2015-11-17 19:16:10,773 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60395/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60395/tests/kraken/driver.html?testName=audio-dft) 19:16:11 INFO - 2015-11-17 19:16:11,360 DEBUG : BROWSER_OUTPUT: RSS: Main: 142049280 19:16:11 INFO - 2015-11-17 19:16:11,361 DEBUG : BROWSER_OUTPUT: 19:16:14 INFO - 2015-11-17 19:16:14,231 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60395/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60395/tests/kraken/driver.html?testName=audio-fft) 19:16:14 INFO - 2015-11-17 19:16:14,806 DEBUG : BROWSER_OUTPUT: RSS: Main: 137146368 19:16:14 INFO - 2015-11-17 19:16:14,807 DEBUG : BROWSER_OUTPUT: 19:16:16 INFO - 2015-11-17 19:16:16,770 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60395/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60395/tests/kraken/driver.html?testName=audio-oscillator) 19:16:17 INFO - 2015-11-17 19:16:17,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 137646080 19:16:17 INFO - 2015-11-17 19:16:17,352 DEBUG : BROWSER_OUTPUT: 19:16:19 INFO - 2015-11-17 19:16:19,531 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60395/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60395/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:16:20 INFO - 2015-11-17 19:16:20,112 DEBUG : BROWSER_OUTPUT: RSS: Main: 138018816 19:16:20 INFO - 2015-11-17 19:16:20,112 DEBUG : BROWSER_OUTPUT: 19:16:23 INFO - 2015-11-17 19:16:23,136 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60395/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60395/tests/kraken/driver.html?testName=imaging-darkroom) 19:16:23 INFO - 2015-11-17 19:16:23,722 DEBUG : BROWSER_OUTPUT: RSS: Main: 137277440 19:16:23 INFO - 2015-11-17 19:16:23,722 DEBUG : BROWSER_OUTPUT: 19:16:27 INFO - 2015-11-17 19:16:27,131 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60395/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60395/tests/kraken/driver.html?testName=imaging-desaturate) 19:16:27 INFO - 2015-11-17 19:16:27,723 DEBUG : BROWSER_OUTPUT: RSS: Main: 138674176 19:16:27 INFO - 2015-11-17 19:16:27,724 DEBUG : BROWSER_OUTPUT: 19:16:30 INFO - 2015-11-17 19:16:30,564 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60395/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60395/tests/kraken/driver.html?testName=json-parse-financial) 19:16:31 INFO - 2015-11-17 19:16:31,146 DEBUG : BROWSER_OUTPUT: RSS: Main: 139247616 19:16:31 INFO - 2015-11-17 19:16:31,146 DEBUG : BROWSER_OUTPUT: 19:16:32 INFO - 2015-11-17 19:16:32,720 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60395/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60395/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:16:33 INFO - 2015-11-17 19:16:33,294 DEBUG : BROWSER_OUTPUT: RSS: Main: 139206656 19:16:33 INFO - 2015-11-17 19:16:33,294 DEBUG : BROWSER_OUTPUT: 19:16:35 INFO - 2015-11-17 19:16:35,125 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60395/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60395/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:16:35 INFO - 2015-11-17 19:16:35,739 DEBUG : BROWSER_OUTPUT: RSS: Main: 139923456 19:16:35 INFO - 2015-11-17 19:16:35,739 DEBUG : BROWSER_OUTPUT: 19:16:37 INFO - 2015-11-17 19:16:37,823 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60395/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60395/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:16:38 INFO - 2015-11-17 19:16:38,424 DEBUG : BROWSER_OUTPUT: RSS: Main: 139538432 19:16:38 INFO - 2015-11-17 19:16:38,424 DEBUG : BROWSER_OUTPUT: 19:16:40 INFO - 2015-11-17 19:16:40,884 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60395/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60395/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:16:41 INFO - 2015-11-17 19:16:41,473 DEBUG : BROWSER_OUTPUT: RSS: Main: 140050432 19:16:41 INFO - 2015-11-17 19:16:41,473 DEBUG : BROWSER_OUTPUT: 19:16:44 INFO - 2015-11-17 19:16:44,097 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60395/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60395/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:16:44 INFO - 2015-11-17 19:16:44,683 DEBUG : BROWSER_OUTPUT: RSS: Main: 138821632 19:16:44 INFO - 2015-11-17 19:16:44,683 DEBUG : BROWSER_OUTPUT: 19:16:46 INFO - 2015-11-17 19:16:46,340 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60395/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60395/tests/kraken/driver.html?testName=ai-astar) 19:16:46 INFO - 2015-11-17 19:16:46,590 DEBUG : BROWSER_OUTPUT: RSS: Main: 139694080 19:16:46 INFO - 2015-11-17 19:16:46,590 DEBUG : BROWSER_OUTPUT: 19:16:46 INFO - 2015-11-17 19:16:46,593 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:16:46 INFO - 2015-11-17 19:16:46,593 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:16:46 INFO - 2015-11-17 19:16:46,594 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:16:46 INFO - 2015-11-17 19:16:46,594 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:16:46 INFO - 2015-11-17 19:16:46,594 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;103;116;110;111;122;112;112;110;110 19:16:46 INFO - 2015-11-17 19:16:46,594 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;161;127;148;165;129;151;154;136;164;128 19:16:46 INFO - 2015-11-17 19:16:46,594 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;162;162;163;163;161;163;169;162 19:16:46 INFO - 2015-11-17 19:16:46,594 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;74;73;73;72;139;73;74;73;73 19:16:46 INFO - 2015-11-17 19:16:46,594 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;90;136;90;91;90;136;89;90;136 19:16:46 INFO - 2015-11-17 19:16:46,594 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;110;109;111;110;109;110;110 19:16:46 INFO - 2015-11-17 19:16:46,595 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;147;148;147;146;147;147;147;147;146 19:16:46 INFO - 2015-11-17 19:16:46,595 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;97;98;96;97;97;97 19:16:46 INFO - 2015-11-17 19:16:46,595 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;63;62;61;61;61;62;61;58;64 19:16:46 INFO - 2015-11-17 19:16:46,595 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;69;70;71;69;69;70;70;70 19:16:46 INFO - 2015-11-17 19:16:46,595 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;87;87;86;85;85;84;85;88;87 19:16:46 INFO - 2015-11-17 19:16:46,595 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;121;120;123;123;123;118;137;118;121 19:16:46 INFO - 2015-11-17 19:16:46,595 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;142;149;148;164;158;150;148;161;151 19:16:46 INFO - 2015-11-17 19:16:46,596 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;68;68;67;66;69;66;67;66;67 19:16:46 INFO - 2015-11-17 19:16:46,596 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:16:46 INFO - 2015-11-17 19:16:46,596 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:16:46 INFO - 2015-11-17 19:16:46,596 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,717 19:16:46 INFO - 2015-11-17 19:16:46,596 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:16:46 INFO - 2015-11-17 19:16:46,596 DEBUG : BROWSER_OUTPUT: __startTimestamp1447816606591__endTimestamp 19:16:46 INFO - 2015-11-17 19:16:46,596 DEBUG : BROWSER_OUTPUT: 19:16:46 INFO - 2015-11-17 19:16:46,604 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:16:46 INFO - 2015-11-17 19:16:46,604 DEBUG : BROWSER_OUTPUT: Number of tests: 14 19:16:46 INFO - 2015-11-17 19:16:46,604 DEBUG : BROWSER_OUTPUT: 19:16:46 INFO - 2015-11-17 19:16:46,604 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.70 Median:111.50 stddev:4.83 (4.3%) stddev-sans-first:5.12 19:16:46 INFO - 2015-11-17 19:16:46,605 DEBUG : BROWSER_OUTPUT: Values: 111.0 103.0 116.0 110.0 111.0 122.0 112.0 112.0 110.0 110.0 19:16:46 INFO - 2015-11-17 19:16:46,605 DEBUG : BROWSER_OUTPUT: 19:16:46 INFO - 2015-11-17 19:16:46,605 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.30 Median:152.50 stddev:15.19 (10.0%) stddev-sans-first:15.15 19:16:46 INFO - 2015-11-17 19:16:46,605 DEBUG : BROWSER_OUTPUT: Values: 161.0 127.0 148.0 165.0 129.0 151.0 154.0 136.0 164.0 128.0 19:16:46 INFO - 2015-11-17 19:16:46,605 DEBUG : BROWSER_OUTPUT: 19:16:46 INFO - 2015-11-17 19:16:46,605 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.90 Median:162.50 stddev:2.23 (1.4%) stddev-sans-first:2.35 19:16:46 INFO - 2015-11-17 19:16:46,605 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 162.0 162.0 163.0 163.0 161.0 163.0 169.0 162.0 19:16:46 INFO - 2015-11-17 19:16:46,605 DEBUG : BROWSER_OUTPUT: 19:16:46 INFO - 2015-11-17 19:16:46,605 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.60 Median:73.00 stddev:20.88 (28.6%) stddev-sans-first:21.97 19:16:46 INFO - 2015-11-17 19:16:46,605 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 73.0 73.0 72.0 139.0 73.0 74.0 73.0 73.0 19:16:46 INFO - 2015-11-17 19:16:46,606 DEBUG : BROWSER_OUTPUT: 19:16:46 INFO - 2015-11-17 19:16:46,606 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.80 Median:90.00 stddev:22.23 (24.7%) stddev-sans-first:23.01 19:16:46 INFO - 2015-11-17 19:16:46,606 DEBUG : BROWSER_OUTPUT: Values: 90.0 90.0 136.0 90.0 91.0 90.0 136.0 89.0 90.0 136.0 19:16:46 INFO - 2015-11-17 19:16:46,606 DEBUG : BROWSER_OUTPUT: 19:16:46 INFO - 2015-11-17 19:16:46,606 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 19:16:46 INFO - 2015-11-17 19:16:46,606 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 110.0 109.0 111.0 110.0 109.0 110.0 110.0 19:16:46 INFO - 2015-11-17 19:16:46,606 DEBUG : BROWSER_OUTPUT: 19:16:46 INFO - 2015-11-17 19:16:46,606 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.60 19:16:46 INFO - 2015-11-17 19:16:46,606 DEBUG : BROWSER_OUTPUT: Values: 149.0 147.0 148.0 147.0 146.0 147.0 147.0 147.0 147.0 146.0 19:16:46 INFO - 2015-11-17 19:16:46,606 DEBUG : BROWSER_OUTPUT: 19:16:46 INFO - 2015-11-17 19:16:46,606 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 19:16:46 INFO - 2015-11-17 19:16:46,607 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 97.0 98.0 96.0 97.0 97.0 97.0 19:16:46 INFO - 2015-11-17 19:16:46,607 DEBUG : BROWSER_OUTPUT: 19:16:46 INFO - 2015-11-17 19:16:46,607 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.50 Median:62.00 stddev:1.58 (2.6%) stddev-sans-first:1.67 19:16:46 INFO - 2015-11-17 19:16:46,607 DEBUG : BROWSER_OUTPUT: Values: 62.0 63.0 62.0 61.0 61.0 61.0 62.0 61.0 58.0 64.0 19:16:46 INFO - 2015-11-17 19:16:46,607 DEBUG : BROWSER_OUTPUT: 19:16:46 INFO - 2015-11-17 19:16:46,607 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:70.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 19:16:46 INFO - 2015-11-17 19:16:46,607 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 69.0 70.0 71.0 69.0 69.0 70.0 70.0 70.0 19:16:46 INFO - 2015-11-17 19:16:46,607 DEBUG : BROWSER_OUTPUT: 19:16:46 INFO - 2015-11-17 19:16:46,607 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:86.50 stddev:1.57 (1.8%) stddev-sans-first:1.32 19:16:46 INFO - 2015-11-17 19:16:46,607 DEBUG : BROWSER_OUTPUT: Values: 83.0 87.0 87.0 86.0 85.0 85.0 84.0 85.0 88.0 87.0 19:16:46 INFO - 2015-11-17 19:16:46,608 DEBUG : BROWSER_OUTPUT: 19:16:46 INFO - 2015-11-17 19:16:46,608 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.00 Median:123.00 stddev:5.50 (4.5%) stddev-sans-first:5.72 19:16:46 INFO - 2015-11-17 19:16:46,608 DEBUG : BROWSER_OUTPUT: Values: 126.0 121.0 120.0 123.0 123.0 123.0 118.0 137.0 118.0 121.0 19:16:46 INFO - 2015-11-17 19:16:46,608 DEBUG : BROWSER_OUTPUT: 19:16:46 INFO - 2015-11-17 19:16:46,608 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.10 Median:150.50 stddev:7.77 (5.2%) stddev-sans-first:7.12 19:16:46 INFO - 2015-11-17 19:16:46,608 DEBUG : BROWSER_OUTPUT: Values: 140.0 142.0 149.0 148.0 164.0 158.0 150.0 148.0 161.0 151.0 19:16:46 INFO - 2015-11-17 19:16:46,608 DEBUG : BROWSER_OUTPUT: 19:16:46 INFO - 2015-11-17 19:16:46,608 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.99 (1.5%) stddev-sans-first:1.05 19:16:46 INFO - 2015-11-17 19:16:46,609 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 68.0 67.0 66.0 69.0 66.0 67.0 66.0 67.0 19:16:46 INFO - 2015-11-17 19:16:46,609 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:16:46 INFO - 2015-11-17 19:16:46,609 DEBUG : BROWSER_OUTPUT: 19:16:47 INFO - 2015-11-17 19:16:47,477 INFO : Browser exited with error code: 0 19:16:47 INFO - 2015-11-17 19:16:47,530 INFO : Completed test kraken (00:01:00) 19:16:47 INFO - 2015-11-17 19:16:47,530 INFO : Starting test v8_7 19:16:47 INFO - 2015-11-17 19:16:47,530 DEBUG : operating with platform_type : linux_ 19:16:47 INFO - 2015-11-17 19:16:47,531 INFO : Initialising browser for v8_7 test... 19:16:47 INFO - 2015-11-17 19:16:47,536 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpu8h8Aj/profile http://localhost:60395/getInfo.html 19:16:52 INFO - 2015-11-17 19:16:52,391 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:16:52 INFO - 2015-11-17 19:16:52,391 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:16:52 INFO - 2015-11-17 19:16:52,391 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:16:52 INFO - 2015-11-17 19:16:52,391 DEBUG : BROWSER_OUTPUT: __metrics 19:16:53 INFO - 2015-11-17 19:16:53,565 INFO : Browser initialized. 19:16:53 INFO - 2015-11-17 19:16:53,566 INFO : Running cycle 1/1 for v8_7 test... 19:16:53 INFO - 2015-11-17 19:16:53,566 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpu8h8Aj/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:17:05 INFO - 2015-11-17 19:17:05,286 DEBUG : BROWSER_OUTPUT: RSS: Main: 141504512 19:17:05 INFO - 2015-11-17 19:17:05,286 DEBUG : BROWSER_OUTPUT: 19:17:26 INFO - 2015-11-17 19:17:26,684 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60395/tests/v8_7/run.html (next: http://localhost:60395/tests/v8_7/run.html) 19:17:26 INFO - 2015-11-17 19:17:26,942 DEBUG : BROWSER_OUTPUT: RSS: Main: 138747904 19:17:26 INFO - 2015-11-17 19:17:26,943 DEBUG : BROWSER_OUTPUT: 19:17:26 INFO - 2015-11-17 19:17:26,943 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:17:26 INFO - 2015-11-17 19:17:26,943 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:17:26 INFO - 2015-11-17 19:17:26,943 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:17:26 INFO - 2015-11-17 19:17:26,943 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:17:26 INFO - 2015-11-17 19:17:26,943 DEBUG : BROWSER_OUTPUT: |0;Richards;166.27868307283006 19:17:26 INFO - 2015-11-17 19:17:26,943 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.71779141104295 19:17:26 INFO - 2015-11-17 19:17:26,944 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.662363177098 19:17:26 INFO - 2015-11-17 19:17:26,944 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5076.1421319796955 19:17:26 INFO - 2015-11-17 19:17:26,944 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1053.740779768177 19:17:26 INFO - 2015-11-17 19:17:26,944 DEBUG : BROWSER_OUTPUT: |5;Earley;699.3006993006993 19:17:26 INFO - 2015-11-17 19:17:26,944 DEBUG : BROWSER_OUTPUT: |6;Boyer;12192.77108433735 19:17:26 INFO - 2015-11-17 19:17:26,944 DEBUG : BROWSER_OUTPUT: |7;RegExp;24804.878048780487 19:17:26 INFO - 2015-11-17 19:17:26,944 DEBUG : BROWSER_OUTPUT: |8;Splay;692.4128503075872 19:17:26 INFO - 2015-11-17 19:17:26,945 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 19:17:26 INFO - 2015-11-17 19:17:26,945 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:17:26 INFO - 2015-11-17 19:17:26,945 DEBUG : BROWSER_OUTPUT: __startTimestamp1447816646936__endTimestamp 19:17:26 INFO - 2015-11-17 19:17:26,945 DEBUG : BROWSER_OUTPUT: 19:17:26 INFO - 2015-11-17 19:17:26,945 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:17:26 INFO - 2015-11-17 19:17:26,945 DEBUG : BROWSER_OUTPUT: Number of tests: 10 19:17:26 INFO - 2015-11-17 19:17:26,945 DEBUG : BROWSER_OUTPUT: 19:17:26 INFO - 2015-11-17 19:17:26,946 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.28 Median:166.28 stddev:0.00 (0.0%) 19:17:26 INFO - 2015-11-17 19:17:26,946 DEBUG : BROWSER_OUTPUT: Values: 166.3 19:17:26 INFO - 2015-11-17 19:17:26,946 DEBUG : BROWSER_OUTPUT: 19:17:26 INFO - 2015-11-17 19:17:26,946 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.72 Median:191.72 stddev:0.00 (0.0%) 19:17:26 INFO - 2015-11-17 19:17:26,946 DEBUG : BROWSER_OUTPUT: Values: 191.7 19:17:26 INFO - 2015-11-17 19:17:26,946 DEBUG : BROWSER_OUTPUT: 19:17:26 INFO - 2015-11-17 19:17:26,946 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.66 Median:280.66 stddev:0.00 (0.0%) 19:17:26 INFO - 2015-11-17 19:17:26,947 DEBUG : BROWSER_OUTPUT: Values: 280.7 19:17:26 INFO - 2015-11-17 19:17:26,947 DEBUG : BROWSER_OUTPUT: 19:17:26 INFO - 2015-11-17 19:17:26,947 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5076.14 Median:5076.14 stddev:0.00 (0.0%) 19:17:26 INFO - 2015-11-17 19:17:26,947 DEBUG : BROWSER_OUTPUT: Values: 5076.1 19:17:26 INFO - 2015-11-17 19:17:26,947 DEBUG : BROWSER_OUTPUT: 19:17:26 INFO - 2015-11-17 19:17:26,947 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1053.74 Median:1053.74 stddev:0.00 (0.0%) 19:17:26 INFO - 2015-11-17 19:17:26,948 DEBUG : BROWSER_OUTPUT: Values: 1053.7 19:17:26 INFO - 2015-11-17 19:17:26,948 DEBUG : BROWSER_OUTPUT: 19:17:26 INFO - 2015-11-17 19:17:26,948 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:699.30 Median:699.30 stddev:0.00 (0.0%) 19:17:26 INFO - 2015-11-17 19:17:26,948 DEBUG : BROWSER_OUTPUT: Values: 699.3 19:17:26 INFO - 2015-11-17 19:17:26,948 DEBUG : BROWSER_OUTPUT: 19:17:26 INFO - 2015-11-17 19:17:26,948 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12192.77 Median:12192.77 stddev:0.00 (0.0%) 19:17:26 INFO - 2015-11-17 19:17:26,948 DEBUG : BROWSER_OUTPUT: Values: 12192.8 19:17:26 INFO - 2015-11-17 19:17:26,949 DEBUG : BROWSER_OUTPUT: 19:17:26 INFO - 2015-11-17 19:17:26,949 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24804.88 Median:24804.88 stddev:0.00 (0.0%) 19:17:26 INFO - 2015-11-17 19:17:26,949 DEBUG : BROWSER_OUTPUT: Values: 24804.9 19:17:26 INFO - 2015-11-17 19:17:26,949 DEBUG : BROWSER_OUTPUT: 19:17:26 INFO - 2015-11-17 19:17:26,949 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:692.41 Median:692.41 stddev:0.00 (0.0%) 19:17:26 INFO - 2015-11-17 19:17:26,949 DEBUG : BROWSER_OUTPUT: Values: 692.4 19:17:26 INFO - 2015-11-17 19:17:26,949 DEBUG : BROWSER_OUTPUT: 19:17:26 INFO - 2015-11-17 19:17:26,949 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 19:17:26 INFO - 2015-11-17 19:17:26,949 DEBUG : BROWSER_OUTPUT: Values: 4830.9 19:17:26 INFO - 2015-11-17 19:17:26,949 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:17:26 INFO - 2015-11-17 19:17:26,950 DEBUG : BROWSER_OUTPUT: 19:17:27 INFO - 2015-11-17 19:17:27,833 INFO : Browser exited with error code: 0 19:17:27 INFO - 2015-11-17 19:17:27,850 INFO : Completed test v8_7 (00:00:40) 19:17:27 INFO - 2015-11-17 19:17:27,951 INFO : Completed test suite (00:20:11) 19:17:27 INFO - 2015-11-17 19:17:27,951 DEBUG : Working with test: dromaeo_css 19:17:27 INFO - 2015-11-17 19:17:27,951 DEBUG : Generating results file: dromaeo_css 19:17:27 INFO - 2015-11-17 19:17:27,952 DEBUG : Working with test: kraken 19:17:27 INFO - 2015-11-17 19:17:27,952 DEBUG : Generating results file: kraken 19:17:27 INFO - 2015-11-17 19:17:27,952 INFO : javascript benchmark 19:17:27 INFO - 2015-11-17 19:17:27,953 DEBUG : Working with test: v8_7 19:17:27 INFO - 2015-11-17 19:17:27,953 DEBUG : Generating results file: v8_7 19:17:27 INFO - 2015-11-17 19:17:27,953 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:17:28 INFO - 2015-11-17 19:17:28,003 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 19:17:28 INFO - 2015-11-17 19:17:28,003 DEBUG : process_Request line: dromaeo_css 6758.40 graph.html#tests=[[72,64,43]] 19:17:28 INFO - 2015-11-17 19:17:28,004 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:17:28 INFO - 2015-11-17 19:17:28,032 DEBUG : process_Request line: kraken 1515.90 graph.html#tests=[[232,64,43]] 19:17:28 INFO - 2015-11-17 19:17:28,032 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:17:28 INFO - 2015-11-17 19:17:28,058 DEBUG : process_Request line: v8_7 21207.46 graph.html#tests=[[230,64,43]] 19:17:28 INFO - 2015-11-17 19:17:28,059 INFO : javascript benchmark 19:17:28 INFO - 2015-11-17 19:17:28,063 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [356.8037579331367, 356.99286014279716, 358.82238292045434, 361.30268581637444, 361.7377401383997, 14584.979051466402, 14661.193634350106, 15718.764218536731, 16258.268377922992, 17131.400400985982, 16578.83421165788, 16634.75047874283, 16703.83296167038, 17036.063016534084, 17054.914725426388, 5512.310961129859, 5620.381758006616, 5667.121596152582, 5668.943310566903, 5679.602427830054, 5522.502974732273, 5600.18797274395, 5633.380328163898, 5659.971700141494, 5664.065429204197, 5566.526845218162, 5601.411851755568, 5601.60788744786, 5607.383187849333, 5608.411116832735, 4958.504149585049, 5578.079616863212, 5588.21764952907, 5594.468525490072, 5594.916076258839, 4362.0, 4372.060007098489, 4374.0, 4382.452193475816, 4384.649228061748, 13717.519886803913, 13802.65493362664, 13862.306884655727, 13888.4444622215, 13927.442902283896, 1993.1130646862152, 2049.0574335805545, 2058.464799152216, 2061.4846288427893, 2072.243631074662, 10105.191584673208, 10122.190224782, 10199.949000255025, 10250.897491025069, 10314.638987635397, 1684.6378028723884, 1706.5562953632145, 1712.7430885367294, 1719.149021234497, 1784.2149454240223, 59633.40366596322, 60279.39720602782, 61082.694586526784, 61094.389056109314, 61270.69364653193, 6966.721331146799, 7072.5402848814665, 7171.354578087893, 7210.351068403764, 7229.7469588564145, 8263.256306932284, 8386.161383861565, 8422.620982055822, 8536.359773017048, 8552.529610871337, 5435.7825686972865, 5439.728013599304, 5534.723263836792, 5541.501264886179, 5555.3611334697025, 5588.826346467206, 5599.244102046253, 5618.438156184349, 5658.858528536737, 5704.828855134353, 3313.7514686398617, 3385.830708464567, 3395.3888300105723, 3413.2490852012515, 3415.3852306585054, 1186.2822992089834, 1191.9642410727693, 1192.7674103549725, 1193.3854065156452, 1213.0538180219444, 441.63123791633706, 457.4236462057831, 467.2220752447137, 480.0, 494.35980405375125, 11793.174477786644, 12020.21868578557, 12270.141090123785, 12467.563635272722, 12495.50017999288, 476.49015553358265, 478.4378355432353, 478.4880178209352, 482.09847585016246, 494.27341807542854, 6519.152510173742, 6690.732370705117, 6699.732010719516, 6716.597004179765, 6734.292899245606, 563839.0, 564964.0, 566886.0, 569414.0, 574249.0, 78032.21967780363, 80242.59878700569, 80340.19659803328, 80361.0, 80745.59627201826, 539.1912131802296, 546.0198942897508, 546.710243570908, 548.0518702644367, 549.0638461423264, 11326.490307936327, 11386.43067846621, 11519.654410367702, 11651.76696466049, 11724.531018759495, 34940.82529587336, 35406.46890296699, 36117.0, 36685.63314366822, 37553.81223093867, 45097.54902451065, 45281.54718452905, 45328.640140795826, 46114.538854611026, 47246.0, 6870.931290687029, 7035.964820175866, 7038.120234970629, 7088.64556772149, 7098.787036388917, 12288.508459661514, 12523.74952500963, 12712.555060572835, 12741.362931853555, 12779.61661150167, 10955.56177752881, 11033.724156895822, 11121.666350009513, 11125.44372781374, 11377.08983281319, 10820.0, 10834.295770774874, 10946.671599852018, 11050.226484146033, 11234.662960111209, 11094.667159985212, 11424.82862757076, 11447.740748517823, 11506.884931150917, 11554.364509952033, 6895.896561551681, 6988.685509151998, 6995.090638217, 7033.261507541634, 7036.472264580279, 10786.0, 11159.442027898735, 11180.105591552494, 11298.322100673986, 11396.0], "dojo.html": [3182.061291918884, 3229.2572708277094, 3253.772235943482, 3272.018394481655, 3277.9016629501125, 5207.765650545725, 5337.092694241988, 5412.621116521845, 5471.50756431921, 5474.178873169021, 5201.843944681666, 5285.392179899312, 5316.574674026078, 5332.14685650296, 5342.839714808552, 4909.631777616675, 5003.624728145385, 5086.3387759591205, 5115.079285728568, 5155.510226528474, 4876.561109500144, 4941.308216849626, 4972.875678108058, 4988.875278118058, 5022.17134172861, 4789.928151077736, 4863.732494712789, 4870.099031679115, 4998.775055122528, 5014.448410674823, 4913.901721965541, 4914.238293064581, 4939.110960027194, 4958.553730164266, 4971.279164521125, 4893.290472881412, 4908.754562271872, 4915.827946021872, 4924.778384972685, 4977.1538838397555, 5240.475952404767, 5246.658967167122, 5295.4969277918535, 5299.33758280215, 5354.464553544653, 5865.178874957509, 5891.0, 5899.144624029492, 5899.262592175978, 5910.0, 5768.3654797972185, 5858.502027327682, 5897.292324921037, 5915.142304365886, 5942.3760505146765, 5258.710770907599, 5359.464053594609, 5359.973200133974, 5360.6247562671015, 5423.538999185074, 5959.821205363846, 5979.820605381846, 5980.910286345708, 5990.041593345044, 6002.789902353396, 5609.5792815539, 5712.200291959129, 5721.0, 5778.046622307273, 5783.103618939072, 5938.970305148533, 5955.970220148958, 5965.0, 5966.31387390447, 5983.1623572699855, 5855.707214639251, 5863.970680146657, 5903.527717782567, 5911.704414779244, 5928.229330187134, 5711.086226203871, 5832.212651292106, 5837.9124313135335, 5935.881282374328, 6001.699915004232, 4570.88572785683, 4571.611413029929, 4582.060677561092, 4588.082383523309, 4621.768911554409, 4066.044479547304, 4078.0, 4091.4067460218102, 4098.057446787256, 4114.177164567099, 5390.51485366311, 5442.319710036246, 5515.696636684941, 5569.972150139304, 5580.1629755537, 5881.382454842265, 5889.823305300848, 5900.763969441175, 5940.108983652401, 5947.316058653224, 5458.399576046631, 5578.776848926079, 5597.63615365, 5609.1305847593685, 5633.802816901471, 4981.90036199274, 4990.575801056878, 4994.575461085776, 5040.319556859777, 5165.638405311592, 6033.637981721111, 6089.8477538061015, 6092.0, 6093.8476538086015, 6097.817065488042, 5875.148103524965, 5882.411758824083, 5903.527717782481, 5909.409059094056, 5910.261217347832, 5842.795502157404, 5905.940940590539, 5962.642241465526, 5997.13041608973, 6103.450689437972, 5653.3216014076925, 5795.536357091339, 5818.679972601548, 5828.271466066742, 5832.854178645568, 5775.335836378702, 5872.677002764889, 5904.409559044061, 5942.405759424023, 5947.137665038459, 5667.291588551431, 5669.149627555735, 5771.076627739541, 5851.356350801493, 5913.586048976703, 5673.234113394639, 5782.190493330853, 5784.768609255582, 5785.0, 5798.391168927202, 5530.419305972976, 5623.662580245198, 5670.0, 5704.258446402107, 5713.371529131875, 5677.77288908439, 5803.9419605803405, 5837.795677151279, 5839.211706419579, 5841.036229022164, 5623.971880140573, 5651.858703532444, 5660.745266463102, 5673.517750991047, 5674.347450043298], "mootools.html": [1504.9991755482604, 1664.3259479910637, 1724.4654157211266, 1734.85253753431, 1754.7981982072065, 7114.608696521689, 7291.5989620570845, 7375.741849035285, 7414.1473730521, 7579.696812127509, 7759.534427934328, 7764.0, 7817.061952565686, 7819.139894611588, 7871.173526779691, 2288.7253529576433, 2333.288347054148, 2336.4158960259933, 2339.63735620979, 2345.636426353918, 2299.287220961499, 2318.8724620145886, 2333.4982978659586, 2335.241046659834, 2337.345543247893, 2237.865728056314, 2256.909723611054, 2280.1677387753434, 2285.6342985122383, 2309.5265470578493, 2238.932832015042, 2261.7851304126166, 2273.59075366434, 2275.8862056897256, 2277.4078739527677, 2243.181238847825, 2312.190733243368, 2314.2131675230335, 2316.3861576682193, 2318.258157389636, 7629.2752188542, 7701.768946931601, 7736.149023607399, 7749.186335434754, 7761.573113478757, 4517.006258623131, 4562.178807814592, 4620.745858977755, 4623.2371658676275, 4625.699329543569, 3071.4778487656927, 3102.395032968572, 3111.859966301522, 3146.7797254192214, 3149.653538110806, 962.1052421248237, 963.0658261486348, 976.5800705696547, 992.7666998255404, 1030.4384110659707, 10383.169346452265, 10394.63618773347, 10413.687589372332, 10480.68557943263, 10491.58033678652, 4011.0574015106426, 4087.836486540505, 4137.793110344471, 4139.710220284612, 4145.91708165835, 8446.155384461628, 8463.53450560225, 8466.06873243955, 8477.0, 8530.744077677555, 4570.720198344469, 4572.51988541205, 4575.519570445055, 4594.563516465931, 4612.192866248393, 4200.306949353384, 4202.684798640114, 4209.2423363794815, 4211.241976444269, 4218.409422680827, 3466.9826650866585, 3489.8778542750883, 3491.1097670093964, 3494.8427320770625, 3499.9825000874835, 1063.7393838509615, 1066.3069005146717, 1072.7747173093583, 1077.52050337599, 1083.21466936472, 1081.2701426537212, 1085.2077983072402, 1134.115389995788, 1239.8078297863844, 1290.1162703547911, 7219.422446204291, 7245.818854528574, 7247.057882475245, 7254.056972593529, 7289.708411663474, 1130.5929865248668, 1132.5243397772956, 1144.2447984330302, 1150.7238262816863, 1155.5955415604471, 5639.266895303666, 5784.797532086357, 5798.6810725410505, 5805.970970145122, 5841.474267315962, 8860.512671802984, 8902.198802107841, 9018.729438116867, 9036.32227582934, 9124.406913550598, 9063.501507417024, 9116.042815504408, 9127.497987610745, 9139.543022848831, 9152.95423522878, 6993.685284162225, 7052.576845389191, 7137.785866424016, 7138.9286107139305, 7174.0, 6896.517243792886, 6906.827329316808, 6946.479014073863, 6948.583085014915, 6951.44388448933, 7576.356009739234, 7776.92223077762, 7816.960915195387, 7917.604119793872, 7972.681092756225, 7945.960270198612, 8007.719729809429, 8151.225633564802, 8180.67277308901, 8330.458520196167, 6831.419329357061, 6847.691853866489, 6858.794236172923, 6943.618101004493, 6962.408195303456, 7437.851242975218, 7445.2182520836695, 7454.589997550187, 7475.850482990201, 7506.474546781673, 6913.10129683138, 6939.4448444125355, 6947.5831450113155, 7074.257202993817, 7104.964475177591, 6354.6822658867795, 6476.4495017924, 6645.734170633314, 6656.933430665631, 6849.212340580897, 6655.833604159935, 6664.633445160563, 6685.665716714242, 6707.128073350434, 6720.059191713066, 6146.262448506208, 6232.781852635136, 6260.405261500332, 6372.171617689671, 6473.449756770728, 6494.285628580947, 6534.705938232696, 6560.40956313934, 6572.047053177167, 6586.604803711793], "ext.html": [559.8768270980386, 591.5179129009857, 602.5571205164204, 607.0681503891526, 607.0954278125594, 30497.542536861936, 40154.397684034724, 40233.798831005806, 40259.0, 40381.3942790858, 43125.137497250114, 43146.78426607871, 43273.0, 43390.56609433905, 43494.7825260874, 8747.693830715942, 8798.86801697975, 8875.423097498642, 8900.19898209161, 8922.776930576754, 8681.782955426102, 8755.56222188888, 8812.295016398704, 8830.161134692225, 8846.778830529223, 8672.653093876237, 8680.392372533925, 8711.825763484727, 8722.433041852259, 8737.126287371275, 8788.69239576615, 8861.778455538599, 8863.822723545525, 8867.423617464909, 8872.955635221848, 8669.609867555975, 8763.78090547735, 8776.868346974801, 8817.338699597492, 8823.69117080899, 39840.20319593621, 40207.396889046686, 40330.193396131916, 40454.393184102264, 40480.0, 3201.375731732313, 3237.7733558650903, 3293.736501079908, 3573.3746594345885, 3640.2537479816574, 29507.409851802844, 29846.552301715492, 29950.400991980256, 30102.84948575265, 30851.845740771376, 3380.3746306933294, 3412.8293585320635, 3428.9314213715834, 3535.328287625343, 3551.94672079919, 259815.0, 261670.9999999981, 262603.0, 262651.0, 263249.0, 41536.37695434571, 41930.0, 41976.790116049226, 42200.0, 42271.57728422738, 39792.801035994635, 39793.80103099466, 39927.600723992386, 40078.0, 40116.398254026215, 13485.056046076877, 13551.932240338736, 13558.186508809504, 13570.728585428433, 13572.728545429036, 10504.107150892107, 10523.789524209626, 10556.788864222672, 10654.254202205771, 10835.83746243807, 12393.938030309972, 12425.19236249641, 12462.189957652723, 12489.625311240678, 12562.748745025048, 5702.173184888168, 5781.277340332458, 5828.970855145697, 5833.183354330397, 5861.531077513789, 895.5029958373166, 999.9050090241416, 1059.7085801404676, 1117.804384232756, 1141.4806263150247, 28236.71763282382, 28270.434591308058, 28463.857680711877, 28648.0, 32384.83807580947, 1012.8655905386015, 1031.3090229546071, 1045.8901815309434, 1095.8739744929435, 1127.115214556569, 16813.243404046847, 17002.404915827887, 17265.223064961854, 17290.567735806453, 17327.2202750874, 406605.0, 408301.0, 411037.0, 411443.0, 413098.0, 55006.44993550093, 55083.0, 55349.169762453595, 55376.44623553794, 55396.446035539935, 1325.6619562011626, 1328.9800652990214, 1344.3681469709024, 1353.289523000413, 1356.4641966423208, 28966.0, 30405.543916840823, 31331.0, 32403.0, 32580.102527241674, 49466.75266623644, 50002.249966251264, 50021.749891250314, 50145.74927125341, 50283.24575131303, 305356.0, 308720.0, 308830.0, 308859.0, 309536.0, 41664.58335416607, 42012.159756805304, 45640.771796140805, 46192.30711539262, 46733.2990005157, 43286.56713432825, 43743.78128109339, 43960.12079758323, 44082.0, 44226.33660495031, 36628.81685591555, 36912.0, 37534.249315014094, 38047.61952380441, 38382.424263636625, 36509.45235821518, 36968.26063478769, 37081.62918370782, 37391.6260837399, 40304.59695403009, 35995.0, 36434.0, 36467.27065458623, 36482.452763209105, 36589.26821463609, 31789.523157152198, 32869.34261314808, 34042.82978585091, 34048.14879628029, 34309.48535772015, 25635.871820640776, 25647.358816029748, 25655.0, 25794.8710256455, 25823.0], "prototype.html": [330.2075019952115, 339.9762016658833, 340.05464807834215, 343.2174641816659, 349.4810206842838, 6335.746570137195, 6356.237251529823, 6365.554411191219, 6390.105385246064, 6470.805875823721, 6300.149479820223, 6369.363063693629, 6373.330800265975, 6377.6173429594255, 6380.1386812780265, 4803.135435621587, 4809.350737650408, 4813.975930120362, 4814.181589129839, 4816.060868130716, 4805.423349198101, 4808.735519546423, 4812.0, 4822.156122678517, 4828.7585620719, 4672.486026537078, 4745.074710431467, 4753.572178503934, 4760.047990401933, 4761.428628564577, 4714.057188562301, 4720.315554244649, 4720.575148236658, 4723.48041715411, 4738.786754596052, 4082.5509193988637, 4096.713230073896, 4109.4246805447265, 4114.506259248879, 4120.134771697947, 5921.378255283176, 5970.432808883193, 5977.46202841742, 5983.970080149571, 5993.820185394445, 5380.2736630555155, 5539.14143307788, 5548.001359755242, 5552.91670624941, 5553.333599967989, 6639.701213445406, 6655.700493477805, 6701.899471507932, 6708.027336036296, 6714.959181326903, 4536.34223037661, 4553.704009239389, 4563.543645635443, 4571.040081582872, 4578.885527861797, 6802.625855577941, 6913.481488888354, 6957.9304206958295, 7033.0, 7050.5546362995465, 4650.976745116321, 4688.789004494806, 4707.811687532529, 4712.670113092119, 4722.291656251589, 4754.595859351924, 4771.188897887368, 4778.187708089633, 4778.593819525309, 4780.972091000452, 5526.613137080366, 5533.446655334515, 5537.2524709163745, 5537.390887002426, 5549.028919939075, 6618.470522358296, 6804.217514985741, 6820.079289295981, 6841.692123854438, 6850.143732033496, 1640.4422496351299, 1678.446112782803, 1689.1723055702616, 1690.0366790929052, 1691.8900271482314, 1119.171812858479, 1126.3242054767074, 1127.5961428022165, 1128.430142777892, 1139.32779660001, 6437.742490300429, 6441.452476539453, 6464.676766161673, 6466.612003279818, 6470.967645161744, 6826.590404575742, 6865.588064716033, 6882.518223724392, 6886.51794374399, 6890.414314783199, 6382.712777925005, 6419.1334169887405, 6427.132337134521, 6433.906235939901, 6451.967740161363, 3814.1608846053823, 3828.5405751310022, 3845.807709614508, 3851.2297540492013, 3854.094287842355, 7309.378702810214, 7322.231165727629, 7330.376917962033, 7348.485606007635, 7360.889586656204, 7111.608861512666, 7215.675294611755, 7255.419566434673, 7266.237045110293, 7275.0, 7290.854182916312, 7334.376577990931, 7358.300961408658, 7368.447366447431, 7370.078740157481, 6998.545094568837, 7037.296270372922, 7047.048648432396, 7057.929420705727, 7063.964680176567, 6781.559198652072, 6963.373296403348, 6987.091678081817, 6990.545614535039, 7008.859822803617, 7304.744333948499, 7328.790749526482, 7355.374793142642, 7364.594947277951, 7367.115946086504, 4671.019085991844, 4695.084458530554, 4706.058788242433, 4707.129181101507, 4710.458297295855, 6826.761063362758, 6877.4841886857685, 7021.332973367522, 7077.5399599025895, 7079.079719636415, 6822.0, 6860.0738900247825, 6864.553804002724, 6880.621565813928, 6901.033855260167, 6848.589084654936, 6862.725490980504, 6869.450443964371, 6869.587824730532, 6883.65581720922, 6571.3100124488155, 6677.866442671217, 6727.293634168342, 6731.754625394122, 6752.966235168793, 6887.896681549881, 6902.689378978059, 6908.861822763617, 6912.896306555305, 6918.792436226921, 6711.295313992156, 6732.629705366252, 6734.764283250259, 6735.191776986793, 6737.124173857367], "yui.html": [720.7549433192715, 739.3604532079753, 811.1401913971188, 830.5598033042489, 867.496851825941, 13706.931465342685, 13738.0, 13974.021818472711, 13987.160770353787, 13996.300184990749, 13241.205527668346, 14392.352344144512, 14394.280285985686, 14396.640083997905, 14427.927860360709, 803.052398170159, 809.299955538458, 811.3549727966251, 819.7827575692446, 820.7537738678402, 809.8096947217399, 812.687115460549, 812.7074253268848, 815.4129027100478, 817.6851912013858, 845.5814371885925, 850.9021462531795, 850.9106543812903, 851.059579165023, 851.1573542193246, 848.2238751542332, 848.503625379154, 849.8257857139303, 852.7271273192581, 854.799122206281, 617.8115674719209, 622.3434276837934, 623.4949690750507, 623.9937600623981, 624.7469774741191, 13275.336233188398, 13330.0, 13350.599482015556, 13371.86628133716, 13410.46358145673, 10018.448985305806, 10463.110635595907, 10526.42104684242, 10731.195160363004, 10742.140628749681, 10255.0, 10277.537510812032, 10363.896361036368, 10364.274500784948, 10503.842442363295, 3325.617553981299, 3335.6831101045364, 3338.0, 3343.531905533203, 3350.8827191048194, 46612.53387466116, 46876.765616172044, 46969.765151174026, 47056.2941555877, 47056.76471617654, 7510.662020208994, 7602.42981776369, 7622.809429764189, 7755.2632499912415, 7872.763817085496, 11709.063274937984, 11743.0, 11793.764124717458, 11795.705107372385, 11885.108616853771, 6889.552179108342, 6915.170179578483, 6929.099217101744, 7017.824554386079, 7069.434445244368, 4240.300350442142, 4277.508086570022, 4288.91422171561, 4291.6566674665955, 4347.478302603708, 2725.986370068137, 2726.8636568171514, 2746.835189888613, 2747.697753247141, 2759.0619189475674, 424.22578793701, 433.0580986354666, 433.87200775771225, 434.46560730301906, 436.6026915506873, 505.98229061982653, 551.2888373997579, 624.8968920128128, 664.7133859523225, 666.2338310942455, 7980.401469889782, 7987.349136966506, 7997.800054998672, 8241.95879020601, 8257.628406721711, 548.4323724944663, 583.8306891001647, 595.9970200149058, 644.8065580325883, 656.3370995294691, 3993.5008123984503, 4273.722208056529, 4276.850310239127, 4370.934435983463, 4434.068845542408, 55092.44907550873, 55601.0, 55821.16268255979, 55974.0, 59408.0, 50308.245376319384, 51399.48600513947, 51484.0, 52870.735646321526, 53174.734126329124, 48284.7585762076, 48416.515834841906, 48491.75754121278, 48741.26888096681, 49420.258696119585, 8210.137935516685, 8259.752207433787, 8261.256486916207, 8275.917240827515, 8458.40791144614, 35923.82038089897, 36020.63979360173, 36383.81808090943, 37696.246075078896, 37881.81059094687, 42942.35586466268, 46043.079138417714, 46120.15738347425, 46435.303470447296, 46492.0, 7701.614919253902, 7767.456278060482, 8027.39794515402, 8121.837563248584, 8543.487390756574, 11927.224730392496, 12005.39973001364, 12086.093542984136, 12373.165597583433, 12661.810072849099, 10510.369377837354, 10580.735481612714, 10589.152867770714, 11099.667009989713, 11167.329960202414, 11068.612598559012, 11350.886491134983, 11364.94317528407, 11475.655730328104, 11672.416379181177, 10686.358818470917, 11167.218294719292, 11194.104471642411, 11196.0, 11439.542418303176, 9979.20166386702, 10100.24248181404, 10248.282620216512, 10509.9474502627, 10512.894871051192, 8367.66529338844, 8875.73372798817, 8885.733427997171, 9307.162355388047, 9653.634859459477]}, "summary": {"lowerIsBetter": false, "suite": 6758.401379092851, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7209.865766379806, "unit": "ms", "value": 7209.865766379806}, "dojo.html": {"lowerIsBetter": false, "filtered": 5399.341062440984, "unit": "ms", "value": 5399.341062440984}, "mootools.html": {"lowerIsBetter": false, "filtered": 4414.915308619336, "unit": "ms", "value": 4414.915308619336}, "ext.html": {"lowerIsBetter": false, "filtered": 18208.866637052593, "unit": "ms", "value": 18208.866637052593}, "prototype.html": {"lowerIsBetter": false, "filtered": 5070.731700873627, "unit": "ms", "value": 5070.731700873627}, "yui.html": {"lowerIsBetter": false, "filtered": 6004.608870458926, "unit": "ms", "value": 6004.608870458926}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-044.e"}, "testrun": {"date": 1447815436, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151117173015", "branch": "Fx-Team", "revision": "8e712e56faf8ef12537ad604f38bca4f06665a7b"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 162.0, 162.0, 162.0, 163.0, 163.0, 161.0, 163.0, 169.0, 162.0], "ai-astar": [111.0, 103.0, 116.0, 110.0, 111.0, 122.0, 112.0, 112.0, 110.0, 110.0], "imaging-gaussian-blur": [110.0, 109.0, 110.0, 110.0, 109.0, 111.0, 110.0, 109.0, 110.0, 110.0], "audio-beat-detection": [161.0, 127.0, 148.0, 165.0, 129.0, 151.0, 154.0, 136.0, 164.0, 128.0], "json-stringify-tinderbox": [69.0, 70.0, 69.0, 70.0, 71.0, 69.0, 69.0, 70.0, 70.0, 70.0], "stanford-crypto-pbkdf2": [140.0, 142.0, 149.0, 148.0, 164.0, 158.0, 150.0, 148.0, 161.0, 151.0], "json-parse-financial": [62.0, 63.0, 62.0, 61.0, 61.0, 61.0, 62.0, 61.0, 58.0, 64.0], "stanford-crypto-sha256-iterative": [67.0, 68.0, 68.0, 67.0, 66.0, 69.0, 66.0, 67.0, 66.0, 67.0], "audio-fft": [72.0, 74.0, 73.0, 73.0, 72.0, 139.0, 73.0, 74.0, 73.0, 73.0], "imaging-darkroom": [149.0, 147.0, 148.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0], "stanford-crypto-ccm": [126.0, 121.0, 120.0, 123.0, 123.0, 123.0, 118.0, 137.0, 118.0, 121.0], "audio-oscillator": [90.0, 90.0, 136.0, 90.0, 91.0, 90.0, 136.0, 89.0, 90.0, 136.0], "stanford-crypto-aes": [83.0, 87.0, 87.0, 86.0, 85.0, 85.0, 84.0, 85.0, 88.0, 87.0], "imaging-desaturate": [96.0, 96.0, 96.0, 96.0, 97.0, 98.0, 96.0, 97.0, 97.0, 97.0]}, "summary": {"lowerIsBetter": true, "suite": 1515.8999999999999, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 79.6, "unit": "ms", "value": 79.6}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 151.1, "unit": "ms", "value": 151.1}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 146.3, "unit": "ms", "value": 146.3}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 123.0, "unit": "ms", "value": 123.0}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 147.1, "unit": "ms", "value": 147.1}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 61.5, "unit": "ms", "value": 61.5}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.8, "unit": "ms", "value": 103.8}, "ai-astar": {"lowerIsBetter": true, "filtered": 111.7, "unit": "ms", "value": 111.7}, "audio-dft": {"lowerIsBetter": true, "filtered": 162.9, "unit": "ms", "value": 162.9}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 67.1, "unit": "ms", "value": 67.1}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.7, "unit": "ms", "value": 69.7}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.8, "unit": "ms", "value": 109.8}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.7, "unit": "ms", "value": 85.7}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.6, "unit": "ms", "value": 96.6}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-044.e"}, "testrun": {"date": 1447815436, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151117173015", "branch": "Fx-Team", "revision": "8e712e56faf8ef12537ad604f38bca4f06665a7b"}}, {"talos_counters": {}, "results": {"DeltaBlue": [191.71779141104295], "Encrypt": [280.662363177098], "NavierStokes": [4830.917874396136], "Decrypt": [5076.1421319796955], "Splay": [692.4128503075872], "Richards": [166.27868307283006], "RegExp": [24804.878048780487], "Earley": [699.3006993006993], "Boyer": [12192.77108433735], "RayTrace": [1053.740779768177]}, "summary": {"lowerIsBetter": false, "suite": 21207.45803451402, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 344.87148800000006, "unit": "score", "value": 344.87148800000006}, "Encrypt": {"lowerIsBetter": false, "filtered": 948.4029029999999, "unit": "score", "value": 948.4029029999999}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.1879999999999, "unit": "score", "value": 307.1879999999999}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.43765699999998, "unit": "score", "value": 52.43765699999998}, "Splay": {"lowerIsBetter": false, "filtered": 117.69134550839091, "unit": "score", "value": 117.69134550839091}, "RegExp": {"lowerIsBetter": false, "filtered": 36.72604228121927, "unit": "score", "value": 36.72604228121927}, "Richards": {"lowerIsBetter": false, "filtered": 212.306228, "unit": "score", "value": 212.306228}, "Earley": {"lowerIsBetter": false, "filtered": 953.0420899999998, "unit": "score", "value": 953.0420899999998}, "Boyer": {"lowerIsBetter": false, "filtered": 54.66050296442688, "unit": "score", "value": 54.66050296442688}, "RayTrace": {"lowerIsBetter": false, "filtered": 702.2495610000001, "unit": "score", "value": 702.2495610000001}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-044.e"}, "testrun": {"date": 1447815436, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151117173015", "branch": "Fx-Team", "revision": "8e712e56faf8ef12537ad604f38bca4f06665a7b"}}] 19:17:28 INFO - RETURN: dromaeo_css: 6758.40 19:17:28 INFO - RETURN: kraken: 1515.90 19:17:28 INFO - RETURN: v8_7: 21207.46 19:17:28 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21207.46"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1515.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6758.40"}}} 19:17:28 INFO - Return code: 0 19:17:28 INFO - # TBPL SUCCESS # 19:17:28 INFO - Running post-action listener: _resource_record_post_action 19:17:28 INFO - Running post-run listener: _resource_record_post_run 19:17:29 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 20480; Write bytes: 522027008; Read time: 44; Write time: 714364 19:17:29 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 207507456; Read time: 0; Write time: 379400 19:17:29 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 16384; Write bytes: 279482368; Read time: 28; Write time: 221016 19:17:29 INFO - Running post-run listener: _upload_blobber_files 19:17:29 INFO - Blob upload gear active. 19:17:29 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 19:17:29 INFO - Copying logs to upload dir... 19:17:29 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1265.710907 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-11-17 19:17:29.041455) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 19:17:29.045217) ========= 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=0cff312cb257a7829adc5a5d000001df-1447814749.804333-1409711051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010130 build_url: 'https://queue.taskcluster.net/v1/task/nX3YYY2xQDeU6ir8qOW_zg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 19:17:29.097701) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 19:17:29.098235) ========= 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=0cff312cb257a7829adc5a5d000001df-1447814749.804333-1409711051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004767 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 19:17:29.149173) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 19:17:29.149482) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 19:17:29.150030) ========= ========= Total master_lag: 0.18 =========