builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-041 starttime: 1447826262.39 results: success (0) buildid: 20151117203118 builduid: 706f7c419c5b4c02ba7fa934a09010be revision: 6fa3b2df62cc80058ea2f63834dcbdd6ec7caa36 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:42.388612) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:42.389628) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:42.390363) ========= 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=7f67ac1ceef7774224e327f2000001f6-1447826149.898596-1319257888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006563 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.60 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:42.992332) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:42.992646) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:43.024803) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:43.025179) ========= 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=7f67ac1ceef7774224e327f2000001f6-1447826149.898596-1319257888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.045559 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:43.083480) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:43.083817) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:43.084211) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:43.084526) ========= 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=7f67ac1ceef7774224e327f2000001f6-1447826149.898596-1319257888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-17 21:57:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.9M=0s 2015-11-17 21:57:43 (38.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.211277 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:43.313453) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:43.313795) ========= 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=7f67ac1ceef7774224e327f2000001f6-1447826149.898596-1319257888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.139825 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:43.467403) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:43.468152) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6fa3b2df62cc80058ea2f63834dcbdd6ec7caa36 --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 6fa3b2df62cc80058ea2f63834dcbdd6ec7caa36 --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=7f67ac1ceef7774224e327f2000001f6-1447826149.898596-1319257888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-17 21:57:43,530 truncating revision to first 12 chars 2015-11-17 21:57:43,530 Setting DEBUG logging. 2015-11-17 21:57:43,530 attempt 1/10 2015-11-17 21:57:43,530 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6fa3b2df62cc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 21:57:43,778 unpacking tar archive at: fx-team-6fa3b2df62cc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.519467 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:44.002048) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:44.002388) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:44.010483) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:44.010827) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:44.011331) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2015-11-17 21:57:44.011706) ========= /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=7f67ac1ceef7774224e327f2000001f6-1447826149.898596-1319257888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:57:44 INFO - MultiFileLogger online at 20151117 21:57:44 in /builds/slave/test-pgo 21:57:44 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 21:57:44 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:57:44 INFO - {'append_to_log': False, 21:57:44 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:57:44 INFO - 'blob_upload_branch': 'Fx-Team', 21:57:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:57:44 INFO - 'branch': 'Fx-Team', 21:57:44 INFO - 'buildbot_json_path': 'buildprops.json', 21:57:44 INFO - 'config_files': ('talos/linux_config.py',), 21:57:44 INFO - 'default_actions': ('clobber', 21:57:44 INFO - 'read-buildbot-config', 21:57:44 INFO - 'download-and-extract', 21:57:44 INFO - 'populate-webroot', 21:57:44 INFO - 'create-virtualenv', 21:57:44 INFO - 'install', 21:57:44 INFO - 'run-tests'), 21:57:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:57:44 INFO - 'download_minidump_stackwalk': True, 21:57:44 INFO - 'download_symbols': 'ondemand', 21:57:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:57:44 INFO - 'tooltool.py': '/tools/tooltool.py', 21:57:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:57:44 INFO - '/tools/misc-python/virtualenv.py')}, 21:57:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:57:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:57:44 INFO - 'installer_path': 'installer.exe', 21:57:44 INFO - 'log_level': 'info', 21:57:44 INFO - 'log_name': 'talos', 21:57:44 INFO - 'log_to_console': True, 21:57:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:57:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:57:44 INFO - 'opt_config_files': (), 21:57:44 INFO - 'pip_index': False, 21:57:44 INFO - 'sps_profile': False, 21:57:44 INFO - 'sps_profile_interval': 0, 21:57:44 INFO - 'suite': 'dromaeojs-e10s', 21:57:44 INFO - 'system_bits': '64', 21:57:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:57:44 INFO - 'title': 'talos-linux64-ix-041', 21:57:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:57:44 INFO - 'use_talos_json': True, 21:57:44 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:57:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:57:44 INFO - 'work_dir': 'build'} 21:57:44 INFO - ##### 21:57:44 INFO - ##### Running clobber step. 21:57:44 INFO - ##### 21:57:44 INFO - Running pre-action listener: _resource_record_pre_action 21:57:44 INFO - Running main action method: clobber 21:57:44 INFO - rmtree: /builds/slave/test-pgo/build 21:57:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:57:50 INFO - Running post-action listener: _resource_record_post_action 21:57:50 INFO - ##### 21:57:50 INFO - ##### Running read-buildbot-config step. 21:57:50 INFO - ##### 21:57:50 INFO - Running pre-action listener: _resource_record_pre_action 21:57:50 INFO - Running main action method: read_buildbot_config 21:57:50 INFO - Using buildbot properties: 21:57:50 INFO - { 21:57:50 INFO - "properties": { 21:57:50 INFO - "buildnumber": 61, 21:57:50 INFO - "product": "firefox", 21:57:50 INFO - "script_repo_revision": "production", 21:57:50 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 21:57:50 INFO - "repository": "", 21:57:50 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 21:57:50 INFO - "buildid": "20151117203118", 21:57:50 INFO - "slavename": "talos-linux64-ix-041", 21:57:50 INFO - "pgo_build": "True", 21:57:50 INFO - "basedir": "/builds/slave/test-pgo", 21:57:50 INFO - "project": "", 21:57:50 INFO - "platform": "ubuntu64_hw", 21:57:50 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:57:50 INFO - "slavebuilddir": "test", 21:57:50 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 21:57:50 INFO - "branch": "fx-team", 21:57:50 INFO - "repo_path": "integration/fx-team", 21:57:50 INFO - "stage_platform": "linux64-pgo", 21:57:50 INFO - "builduid": "706f7c419c5b4c02ba7fa934a09010be", 21:57:50 INFO - "revision": "6fa3b2df62cc80058ea2f63834dcbdd6ec7caa36" 21:57:50 INFO - }, 21:57:50 INFO - "sourcestamp": { 21:57:50 INFO - "repository": "", 21:57:50 INFO - "hasPatch": false, 21:57:50 INFO - "project": "", 21:57:50 INFO - "branch": "fx-team-linux64-pgo-talos", 21:57:50 INFO - "changes": [ 21:57:50 INFO - { 21:57:50 INFO - "category": null, 21:57:50 INFO - "files": [ 21:57:50 INFO - { 21:57:50 INFO - "url": null, 21:57:50 INFO - "name": "https://queue.taskcluster.net/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 21:57:50 INFO - } 21:57:50 INFO - ], 21:57:50 INFO - "repository": "", 21:57:50 INFO - "rev": "6fa3b2df62cc80058ea2f63834dcbdd6ec7caa36", 21:57:50 INFO - "who": "sendchange", 21:57:50 INFO - "when": 1447826238, 21:57:50 INFO - "number": 6676100, 21:57:50 INFO - "comments": "", 21:57:50 INFO - "project": "", 21:57:50 INFO - "at": "Tue 17 Nov 2015 21:57:18", 21:57:50 INFO - "branch": "fx-team-linux64-pgo-talos", 21:57:50 INFO - "revlink": "", 21:57:50 INFO - "properties": [ 21:57:50 INFO - [ 21:57:50 INFO - "buildid", 21:57:50 INFO - "20151117203118", 21:57:50 INFO - "Change" 21:57:50 INFO - ], 21:57:50 INFO - [ 21:57:50 INFO - "builduid", 21:57:50 INFO - "706f7c419c5b4c02ba7fa934a09010be", 21:57:50 INFO - "Change" 21:57:50 INFO - ], 21:57:50 INFO - [ 21:57:50 INFO - "pgo_build", 21:57:50 INFO - "True", 21:57:50 INFO - "Change" 21:57:50 INFO - ] 21:57:50 INFO - ], 21:57:50 INFO - "revision": "6fa3b2df62cc80058ea2f63834dcbdd6ec7caa36" 21:57:50 INFO - } 21:57:50 INFO - ], 21:57:50 INFO - "revision": "6fa3b2df62cc80058ea2f63834dcbdd6ec7caa36" 21:57:50 INFO - } 21:57:50 INFO - } 21:57:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 21:57:50 INFO - Running post-action listener: _resource_record_post_action 21:57:50 INFO - ##### 21:57:50 INFO - ##### Running download-and-extract step. 21:57:50 INFO - ##### 21:57:50 INFO - Running pre-action listener: _resource_record_pre_action 21:57:50 INFO - Running main action method: download_and_extract 21:57:50 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:57:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:50 INFO - https://queue.taskcluster.net/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:57:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/test_packages.json 21:57:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/test_packages.json 21:57:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:57:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:57:51 INFO - Downloaded 1302 bytes. 21:57:51 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:57:51 INFO - Using the following test package requirements: 21:57:51 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:57:51 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:57:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:57:51 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:57:51 INFO - u'jsshell-linux-x86_64.zip'], 21:57:51 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:57:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:57:51 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:57:51 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:57:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:57:51 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:57:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:57:51 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:57:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:57:51 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:57:51 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:57:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:57:51 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:57: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')]} 21:57:51 INFO - https://queue.taskcluster.net/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:57:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:57:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:57:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/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 21:57:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/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 21:57:53 INFO - Downloaded 22462057 bytes. 21:57:53 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 21:57:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:57:53 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 21:57:54 INFO - Return code: 0 21:57:54 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 21:57: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')]} 21:57:54 INFO - https://queue.taskcluster.net/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:57:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:57:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:57:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/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 21:57:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/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 21:57:55 INFO - Downloaded 22462057 bytes. 21:57:55 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 21:57:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:57:55 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 21:57:56 INFO - Return code: 0 21:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:56 INFO - https://queue.taskcluster.net/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:57:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:57:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:57:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/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 21:57:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/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 21:57:57 INFO - Downloaded 11131693 bytes. 21:57:57 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 21:57:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:57:57 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 21:57:57 INFO - Return code: 0 21:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:57 INFO - https://queue.taskcluster.net/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:57:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:57:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:57:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/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 21:57:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/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 21:57:59 INFO - Downloaded 57198400 bytes. 21:57:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:57:59 INFO - mkdir: /builds/slave/test-pgo/properties 21:57:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:57:59 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:57:59 INFO - Contents: 21:57:59 INFO - build_url:https://queue.taskcluster.net/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:57:59 INFO - Running post-action listener: _resource_record_post_action 21:57:59 INFO - Running post-action listener: set_extra_try_arguments 21:57:59 INFO - ##### 21:57:59 INFO - ##### Running populate-webroot step. 21:57:59 INFO - ##### 21:57:59 INFO - Running pre-action listener: _resource_record_pre_action 21:57:59 INFO - Running main action method: populate_webroot 21:57:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:57:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:57:59 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 21:57:59 INFO - '../fennec_ids.txt'], 21:57:59 INFO - 'tests': ['tcheck2']}, 21:57:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:57:59 INFO - '--tppagecycles', 21:57:59 INFO - '7'], 21:57:59 INFO - 'tests': ['tsvgm']}}, 21:57:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:57:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:57:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:57:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:57:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:57:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:57:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:57:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:59 INFO - 'talos_options': ['--e10s'], 21:57:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:57:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:59 INFO - 'tests': ['damp', 'tps']}, 21:57:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:59 INFO - 'talos_options': ['--e10s'], 21:57:59 INFO - 'tests': ['damp', 'tps']}, 21:57:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:57:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:57:59 INFO - 'other': {'tests': ['a11yr', 21:57:59 INFO - 'ts_paint', 21:57:59 INFO - 'tpaint', 21:57:59 INFO - 'sessionrestore', 21:57:59 INFO - 'sessionrestore_no_auto_restore']}, 21:57:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:57:59 INFO - 'tests': ['a11yr', 21:57:59 INFO - 'ts_paint', 21:57:59 INFO - 'tpaint', 21:57:59 INFO - 'sessionrestore', 21:57:59 INFO - 'sessionrestore_no_auto_restore']}, 21:57:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:57:59 INFO - 'tests': ['a11yr', 21:57:59 INFO - 'ts_paint', 21:57:59 INFO - 'tpaint', 21:57:59 INFO - 'sessionrestore', 21:57:59 INFO - 'sessionrestore_no_auto_restore']}, 21:57:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:57:59 INFO - 'tests': ['a11yr', 21:57:59 INFO - 'ts_paint', 21:57:59 INFO - 'tpaint', 21:57:59 INFO - 'sessionrestore', 21:57:59 INFO - 'sessionrestore_no_auto_restore']}, 21:57:59 INFO - 'other_l64': {'tests': ['a11yr', 21:57:59 INFO - 'ts_paint', 21:57:59 INFO - 'tpaint', 21:57:59 INFO - 'sessionrestore', 21:57:59 INFO - 'sessionrestore_no_auto_restore']}, 21:57:59 INFO - 'other_nol64': {'tests': ['a11yr', 21:57:59 INFO - 'ts_paint', 21:57:59 INFO - 'tpaint', 21:57:59 INFO - 'sessionrestore', 21:57:59 INFO - 'sessionrestore_no_auto_restore']}, 21:57:59 INFO - 'svgr': {'tests': ['tsvgx', 21:57:59 INFO - 'tsvgr_opacity', 21:57:59 INFO - 'tart', 21:57:59 INFO - 'tscrollx', 21:57:59 INFO - 'cart']}, 21:57:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:57:59 INFO - 'tests': ['tsvgx', 21:57:59 INFO - 'tsvgr_opacity', 21:57:59 INFO - 'tart', 21:57:59 INFO - 'tscrollx', 21:57:59 INFO - 'cart']}, 21:57:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:59 INFO - 'tests': ['tp5o']}, 21:57:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:59 INFO - 'talos_options': ['--e10s'], 21:57:59 INFO - 'tests': ['tp5o']}, 21:57:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:59 INFO - 'talos_options': ['--xperf_path', 21:57:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:57:59 INFO - 'tests': ['tp5n']}, 21:57:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:59 INFO - 'talos_options': ['--e10s', 21:57:59 INFO - '--xperf_path', 21:57:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:57:59 INFO - 'tests': ['tp5n']}}, 21:57:59 INFO - 'talos.zip': {'path': '', 21:57:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:57:59 INFO - Running post-action listener: _resource_record_post_action 21:57:59 INFO - ##### 21:57:59 INFO - ##### Running create-virtualenv step. 21:57:59 INFO - ##### 21:57:59 INFO - Running pre-action listener: _resource_record_pre_action 21:57:59 INFO - Running main action method: create_virtualenv 21:57:59 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:57:59 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 21:57:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:57:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:57:59 INFO - Using real prefix '/usr' 21:57:59 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:57:59 INFO - Installing distribute.............................................................................................................................................................................................done. 21:58:01 INFO - Installing pip.................done. 21:58:01 INFO - Return code: 0 21:58:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:58: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')]} 21:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:58:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:58: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')]} 21:58:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:58:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:58: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', '--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 0x7f72cf926c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27673d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f08c0>, '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 0x279d420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279d8b0>, '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': '7f67ac1ceef7774224e327f2000001f6-1447826149.898596-1319257888', '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 21:58:01 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 21:58:01 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 21:58:01 INFO - Using env: {'DISPLAY': ':0', 21:58:01 INFO - 'HOME': '/home/cltbld', 21:58:01 INFO - 'LANG': 'en_US.UTF-8', 21:58:01 INFO - 'LANGUAGE': 'en_US:en', 21:58:01 INFO - 'LOGNAME': 'cltbld', 21:58:01 INFO - 'MAIL': '/var/mail/cltbld', 21:58:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:58:01 INFO - 'MOZ_NO_REMOTE': '1', 21:58:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:58:01 INFO - 'NO_EM_RESTART': '1', 21:58:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:58:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:58:01 INFO - 'PWD': '/builds/slave/test-pgo', 21:58:01 INFO - 'SHELL': '/bin/bash', 21:58:01 INFO - 'SHLVL': '1', 21:58:01 INFO - 'TERM': 'linux', 21:58:01 INFO - 'TMOUT': '86400', 21:58:01 INFO - 'USER': 'cltbld', 21:58:01 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1447826149.898596-1319257888', 21:58:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:58:01 INFO - '_': '/tools/buildbot/bin/python'} 21:58:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:58:01 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 21:58:01 INFO - Cleaning up... 21:58:02 INFO - Return code: 0 21:58:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:58:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:58:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:58:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:58:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f72cf926c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27673d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f08c0>, '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 0x279d420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279d8b0>, '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': '7f67ac1ceef7774224e327f2000001f6-1447826149.898596-1319257888', '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 21:58:02 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 21:58:02 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 21:58:02 INFO - Using env: {'DISPLAY': ':0', 21:58:02 INFO - 'HOME': '/home/cltbld', 21:58:02 INFO - 'LANG': 'en_US.UTF-8', 21:58:02 INFO - 'LANGUAGE': 'en_US:en', 21:58:02 INFO - 'LOGNAME': 'cltbld', 21:58:02 INFO - 'MAIL': '/var/mail/cltbld', 21:58:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:58:02 INFO - 'MOZ_NO_REMOTE': '1', 21:58:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:58:02 INFO - 'NO_EM_RESTART': '1', 21:58:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:58:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:58:02 INFO - 'PWD': '/builds/slave/test-pgo', 21:58:02 INFO - 'SHELL': '/bin/bash', 21:58:02 INFO - 'SHLVL': '1', 21:58:02 INFO - 'TERM': 'linux', 21:58:02 INFO - 'TMOUT': '86400', 21:58:02 INFO - 'USER': 'cltbld', 21:58:02 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1447826149.898596-1319257888', 21:58:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:58:02 INFO - '_': '/tools/buildbot/bin/python'} 21:58:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:58:02 INFO - Downloading/unpacking psutil>=0.7.1 21:58:02 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 21:58:02 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 21:58:02 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 21:58:02 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 21:58:02 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 21:58:02 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 21:58:03 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 21:58:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:58:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:58:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:58:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:58:04 INFO - Installing collected packages: psutil 21:58:04 INFO - Running setup.py install for psutil 21:58:04 INFO - building 'psutil._psutil_linux' extension 21:58:04 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 21:58:04 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 21:58:04 INFO - building 'psutil._psutil_posix' extension 21:58:04 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 21:58:04 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 21:58:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:58:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:58:04 INFO - Successfully installed psutil 21:58:04 INFO - Cleaning up... 21:58:04 INFO - Return code: 0 21:58:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:58:04 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')]} 21:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:58:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:58:04 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')]} 21:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:58:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:58:04 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 0x7f72cf926c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27673d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f08c0>, '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 0x279d420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279d8b0>, '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': '7f67ac1ceef7774224e327f2000001f6-1447826149.898596-1319257888', '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 21:58:04 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 21:58:04 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 21:58:04 INFO - Using env: {'DISPLAY': ':0', 21:58:04 INFO - 'HOME': '/home/cltbld', 21:58:04 INFO - 'LANG': 'en_US.UTF-8', 21:58:04 INFO - 'LANGUAGE': 'en_US:en', 21:58:04 INFO - 'LOGNAME': 'cltbld', 21:58:04 INFO - 'MAIL': '/var/mail/cltbld', 21:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:58:04 INFO - 'MOZ_NO_REMOTE': '1', 21:58:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:58:04 INFO - 'NO_EM_RESTART': '1', 21:58:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:58:04 INFO - 'PWD': '/builds/slave/test-pgo', 21:58:04 INFO - 'SHELL': '/bin/bash', 21:58:04 INFO - 'SHLVL': '1', 21:58:04 INFO - 'TERM': 'linux', 21:58:04 INFO - 'TMOUT': '86400', 21:58:04 INFO - 'USER': 'cltbld', 21:58:04 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1447826149.898596-1319257888', 21:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:58:04 INFO - '_': '/tools/buildbot/bin/python'} 21:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:58:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:58:04 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 21:58:04 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 21:58:04 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 21:58:04 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 21:58:04 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 21:58:04 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 21:58:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:58:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:58:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:58:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:58:06 INFO - Installing collected packages: mozsystemmonitor 21:58:06 INFO - Running setup.py install for mozsystemmonitor 21:58:06 INFO - Successfully installed mozsystemmonitor 21:58:06 INFO - Cleaning up... 21:58:06 INFO - Return code: 0 21:58:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:58:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:58:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:58:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f72cf926c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27673d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f08c0>, '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 0x279d420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279d8b0>, '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': '7f67ac1ceef7774224e327f2000001f6-1447826149.898596-1319257888', '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 21:58:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 21:58:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:58:06 INFO - Using env: {'DISPLAY': ':0', 21:58:06 INFO - 'HOME': '/home/cltbld', 21:58:06 INFO - 'LANG': 'en_US.UTF-8', 21:58:06 INFO - 'LANGUAGE': 'en_US:en', 21:58:06 INFO - 'LOGNAME': 'cltbld', 21:58:06 INFO - 'MAIL': '/var/mail/cltbld', 21:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:58:06 INFO - 'MOZ_NO_REMOTE': '1', 21:58:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:58:06 INFO - 'NO_EM_RESTART': '1', 21:58:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:58:06 INFO - 'PWD': '/builds/slave/test-pgo', 21:58:06 INFO - 'SHELL': '/bin/bash', 21:58:06 INFO - 'SHLVL': '1', 21:58:06 INFO - 'TERM': 'linux', 21:58:06 INFO - 'TMOUT': '86400', 21:58:06 INFO - 'USER': 'cltbld', 21:58:06 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1447826149.898596-1319257888', 21:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:58:06 INFO - '_': '/tools/buildbot/bin/python'} 21:58:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:58:06 INFO - Downloading/unpacking blobuploader==1.2.4 21:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:58:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:58:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:58:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:58:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:58:08 INFO - Downloading blobuploader-1.2.4.tar.gz 21:58:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:58:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:58:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:58:08 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 21:58:08 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 21:58:08 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 21:58:08 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 21:58:08 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 21:58:08 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 21:58:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:58:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:58:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:58:08 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 21:58:08 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 21:58:08 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 21:58:08 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 21:58:08 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 21:58:08 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 21:58:09 INFO - Downloading docopt-0.6.1.tar.gz 21:58:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:58:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:58:09 INFO - Installing collected packages: blobuploader, requests, docopt 21:58:09 INFO - Running setup.py install for blobuploader 21:58:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:58:09 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:58:09 INFO - Running setup.py install for requests 21:58:09 INFO - Running setup.py install for docopt 21:58:09 INFO - Successfully installed blobuploader requests docopt 21:58:09 INFO - Cleaning up... 21:58:09 INFO - Return code: 0 21:58:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:58:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:58:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:58:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:58:09 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 0x7f72cf926c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27673d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f08c0>, '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 0x279d420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279d8b0>, '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': '7f67ac1ceef7774224e327f2000001f6-1447826149.898596-1319257888', '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 21:58:09 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 21:58:09 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 21:58:09 INFO - Using env: {'DISPLAY': ':0', 21:58:09 INFO - 'HOME': '/home/cltbld', 21:58:09 INFO - 'LANG': 'en_US.UTF-8', 21:58:09 INFO - 'LANGUAGE': 'en_US:en', 21:58:09 INFO - 'LOGNAME': 'cltbld', 21:58:09 INFO - 'MAIL': '/var/mail/cltbld', 21:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:58:09 INFO - 'MOZ_NO_REMOTE': '1', 21:58:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:58:09 INFO - 'NO_EM_RESTART': '1', 21:58:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:58:09 INFO - 'PWD': '/builds/slave/test-pgo', 21:58:09 INFO - 'SHELL': '/bin/bash', 21:58:09 INFO - 'SHLVL': '1', 21:58:09 INFO - 'TERM': 'linux', 21:58:09 INFO - 'TMOUT': '86400', 21:58:09 INFO - 'USER': 'cltbld', 21:58:09 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1447826149.898596-1319257888', 21:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:58:09 INFO - '_': '/tools/buildbot/bin/python'} 21:58:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:58:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:58:09 INFO - Running setup.py (path:/tmp/pip-BWdKCC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:58:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:58:10 INFO - Running setup.py (path:/tmp/pip-mnEeYU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:58:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:58:10 INFO - Running setup.py (path:/tmp/pip-taeWEz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:58:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:58:10 INFO - Running setup.py (path:/tmp/pip-kyRd0e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:58:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:58:10 INFO - Running setup.py (path:/tmp/pip-cbtayZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:58:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:58:10 INFO - Running setup.py (path:/tmp/pip-gY1b7l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:58:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:58:10 INFO - Running setup.py (path:/tmp/pip-LttOrG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:58:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:58:10 INFO - Running setup.py (path:/tmp/pip-jjx6GZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:58:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:58:10 INFO - Running setup.py (path:/tmp/pip-sKBg0D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:58:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:58:10 INFO - Running setup.py (path:/tmp/pip-UvM9Rj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:58:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:58:10 INFO - Running setup.py (path:/tmp/pip-fyD2tK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:58:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:58:10 INFO - Running setup.py (path:/tmp/pip-Z4LrmU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:58:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:58:10 INFO - Running setup.py (path:/tmp/pip-Zpu_Ra-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:58:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:58:10 INFO - Running setup.py (path:/tmp/pip-OocVAn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:58:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:58:10 INFO - Running setup.py (path:/tmp/pip-Y8VtY9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:58:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:58:11 INFO - Running setup.py (path:/tmp/pip-Gm36i0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:58:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:58:11 INFO - Running setup.py (path:/tmp/pip-YgMB_C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:58:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:58:11 INFO - Running setup.py install for manifestparser 21:58:11 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:58:11 INFO - Running setup.py install for mozcrash 21:58:11 INFO - Running setup.py install for mozdebug 21:58:11 INFO - Running setup.py install for mozdevice 21:58:11 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:58:11 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:58:11 INFO - Running setup.py install for mozfile 21:58:11 INFO - Running setup.py install for mozhttpd 21:58:11 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:58:11 INFO - Running setup.py install for mozinfo 21:58:11 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:58:11 INFO - Running setup.py install for mozInstall 21:58:11 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:58:11 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:58:11 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:58:11 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:58:11 INFO - Running setup.py install for mozleak 21:58:12 INFO - Running setup.py install for mozlog 21:58:12 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:58:12 INFO - Running setup.py install for moznetwork 21:58:12 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:58:12 INFO - Running setup.py install for mozprocess 21:58:12 INFO - Running setup.py install for mozprofile 21:58:12 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:58:12 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:58:12 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:58:12 INFO - Running setup.py install for mozrunner 21:58:12 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:58:12 INFO - Running setup.py install for mozscreenshot 21:58:12 INFO - Running setup.py install for moztest 21:58:12 INFO - Running setup.py install for mozversion 21:58:12 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:58:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:58:12 INFO - Cleaning up... 21:58:12 INFO - Return code: 0 21:58:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:58:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:58:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:58:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:58:12 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 0x7f72cf926c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27673d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f08c0>, '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 0x279d420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279d8b0>, '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': '7f67ac1ceef7774224e327f2000001f6-1447826149.898596-1319257888', '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 21:58:12 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 21:58:12 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 21:58:12 INFO - Using env: {'DISPLAY': ':0', 21:58:12 INFO - 'HOME': '/home/cltbld', 21:58:12 INFO - 'LANG': 'en_US.UTF-8', 21:58:12 INFO - 'LANGUAGE': 'en_US:en', 21:58:12 INFO - 'LOGNAME': 'cltbld', 21:58:12 INFO - 'MAIL': '/var/mail/cltbld', 21:58:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:58:12 INFO - 'MOZ_NO_REMOTE': '1', 21:58:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:58:12 INFO - 'NO_EM_RESTART': '1', 21:58:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:58:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:58:12 INFO - 'PWD': '/builds/slave/test-pgo', 21:58:12 INFO - 'SHELL': '/bin/bash', 21:58:12 INFO - 'SHLVL': '1', 21:58:12 INFO - 'TERM': 'linux', 21:58:12 INFO - 'TMOUT': '86400', 21:58:12 INFO - 'USER': 'cltbld', 21:58:12 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1447826149.898596-1319257888', 21:58:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:58:12 INFO - '_': '/tools/buildbot/bin/python'} 21:58:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:58:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:58:13 INFO - Running setup.py (path:/tmp/pip-q5rw7K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:58:13 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)) 21:58:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:58:13 INFO - Running setup.py (path:/tmp/pip-6bi3fC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:58:13 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)) 21:58:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:58:13 INFO - Running setup.py (path:/tmp/pip-NxdICD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:58:13 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)) 21:58:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:58:13 INFO - Running setup.py (path:/tmp/pip-VnJarS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:58:13 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)) 21:58:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:58:13 INFO - Running setup.py (path:/tmp/pip-FvSzZv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:58:13 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)) 21:58:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:58:13 INFO - Running setup.py (path:/tmp/pip-CoK6Gi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:58:13 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)) 21:58:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:58:13 INFO - Running setup.py (path:/tmp/pip-O1oVqN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:58:13 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)) 21:58:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:58:13 INFO - Running setup.py (path:/tmp/pip-S6sgNj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:58:13 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)) 21:58:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:58:13 INFO - Running setup.py (path:/tmp/pip-rBVgTT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:58:13 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)) 21:58:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:58:13 INFO - Running setup.py (path:/tmp/pip-qW4D6B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:58:13 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)) 21:58:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:58:13 INFO - Running setup.py (path:/tmp/pip-boZmLP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:58:13 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)) 21:58:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:58:13 INFO - Running setup.py (path:/tmp/pip-5Hl3Mw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:58:14 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)) 21:58:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:58:14 INFO - Running setup.py (path:/tmp/pip-WZRI0t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:58:14 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)) 21:58:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:58:14 INFO - Running setup.py (path:/tmp/pip-Vjjoxl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:58:14 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)) 21:58:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:58:14 INFO - Running setup.py (path:/tmp/pip-_PsDwM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:58:14 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)) 21:58:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:58:14 INFO - Running setup.py (path:/tmp/pip-6uifTK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:58:14 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)) 21:58:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:58:14 INFO - Running setup.py (path:/tmp/pip-NlvbyM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:58:14 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)) 21:58:14 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)) 21:58:14 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)) 21:58:14 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)) 21:58:14 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)) 21:58:14 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)) 21:58:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:58:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:58:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:58:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:58:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:58:16 INFO - Downloading blessings-1.5.1.tar.gz 21:58:16 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 21:58:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:58:16 INFO - Installing collected packages: blessings 21:58:16 INFO - Running setup.py install for blessings 21:58:16 INFO - Successfully installed blessings 21:58:16 INFO - Cleaning up... 21:58:16 INFO - Return code: 0 21:58:16 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:58:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:58:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:58:16 INFO - Reading from file tmpfile_stdout 21:58:16 INFO - Current package versions: 21:58:16 INFO - argparse == 1.2.1 21:58:16 INFO - blessings == 1.5.1 21:58:16 INFO - blobuploader == 1.2.4 21:58:16 INFO - docopt == 0.6.1 21:58:16 INFO - manifestparser == 1.1 21:58:16 INFO - mozInstall == 1.12 21:58:16 INFO - mozcrash == 0.16 21:58:16 INFO - mozdebug == 0.1 21:58:16 INFO - mozdevice == 0.47 21:58:16 INFO - mozfile == 1.2 21:58:16 INFO - mozhttpd == 0.7 21:58:16 INFO - mozinfo == 0.9 21:58:16 INFO - mozleak == 0.1 21:58:16 INFO - mozlog == 3.0 21:58:16 INFO - moznetwork == 0.27 21:58:16 INFO - mozprocess == 0.22 21:58:16 INFO - mozprofile == 0.27 21:58:16 INFO - mozrunner == 6.11 21:58:16 INFO - mozscreenshot == 0.1 21:58:16 INFO - mozsystemmonitor == 0.0 21:58:16 INFO - moztest == 0.7 21:58:16 INFO - mozversion == 1.4 21:58:16 INFO - psutil == 3.1.1 21:58:16 INFO - requests == 1.2.3 21:58:16 INFO - wsgiref == 0.1.2 21:58:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:58: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')]} 21:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:58:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:58: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')]} 21:58:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:58:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:58:16 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 0x7f72cf926c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27673d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f08c0>, '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 0x279d420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279d8b0>, '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': '7f67ac1ceef7774224e327f2000001f6-1447826149.898596-1319257888', '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 21:58:16 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 21:58:16 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 21:58:16 INFO - Using env: {'DISPLAY': ':0', 21:58:16 INFO - 'HOME': '/home/cltbld', 21:58:16 INFO - 'LANG': 'en_US.UTF-8', 21:58:16 INFO - 'LANGUAGE': 'en_US:en', 21:58:16 INFO - 'LOGNAME': 'cltbld', 21:58:16 INFO - 'MAIL': '/var/mail/cltbld', 21:58:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:58:16 INFO - 'MOZ_NO_REMOTE': '1', 21:58:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:58:16 INFO - 'NO_EM_RESTART': '1', 21:58:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:58:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:58:16 INFO - 'PWD': '/builds/slave/test-pgo', 21:58:16 INFO - 'SHELL': '/bin/bash', 21:58:16 INFO - 'SHLVL': '1', 21:58:16 INFO - 'TERM': 'linux', 21:58:16 INFO - 'TMOUT': '86400', 21:58:16 INFO - 'USER': 'cltbld', 21:58:16 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1447826149.898596-1319257888', 21:58:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:58:16 INFO - '_': '/tools/buildbot/bin/python'} 21:58:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:58:16 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)) 21:58:16 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)) 21:58:16 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)) 21:58:16 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)) 21:58:16 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)) 21:58:16 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)) 21:58:16 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)) 21:58:16 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)) 21:58:16 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)) 21:58:16 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)) 21:58:16 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)) 21:58:16 INFO - Cleaning up... 21:58:16 INFO - Return code: 0 21:58:16 INFO - Running post-action listener: _resource_record_post_action 21:58:16 INFO - Running post-action listener: _start_resource_monitoring 21:58:16 INFO - Starting resource monitoring. 21:58:16 INFO - ##### 21:58:16 INFO - ##### Running install step. 21:58:16 INFO - ##### 21:58:16 INFO - Running pre-action listener: _resource_record_pre_action 21:58:16 INFO - Running main action method: install 21:58:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:58:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:58:16 INFO - Reading from file tmpfile_stdout 21:58:16 INFO - Detecting whether we're running mozinstall >=1.0... 21:58:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:58:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:58:17 INFO - Reading from file tmpfile_stdout 21:58:17 INFO - Output received: 21:58:17 INFO - Usage: mozinstall [options] installer 21:58:17 INFO - Options: 21:58:17 INFO - -h, --help show this help message and exit 21:58:17 INFO - -d DEST, --destination=DEST 21:58:17 INFO - Directory to install application into. [default: 21:58:17 INFO - "/builds/slave/test-pgo"] 21:58:17 INFO - --app=APP Application being installed. [default: firefox] 21:58:17 INFO - mkdir: /builds/slave/test-pgo/build/application 21:58:17 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'] 21:58:17 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 21:58:31 INFO - Reading from file tmpfile_stdout 21:58:31 INFO - Output received: 21:58:31 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:58:31 INFO - Running post-action listener: _resource_record_post_action 21:58:31 INFO - ##### 21:58:31 INFO - ##### Running run-tests step. 21:58:31 INFO - ##### 21:58:31 INFO - Running pre-action listener: _resource_record_pre_action 21:58:31 INFO - Running main action method: run_tests 21:58:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:58:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:58:31 INFO - Python 2.7.3 21:58:31 INFO - Return code: 0 21:58:31 INFO - grabbing minidump binary from tooltool 21:58:31 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')]} 21:58:31 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 0x27f08c0>, '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 0x279d420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279d8b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:58:31 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 21:58:31 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 21:58:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:58:31 INFO - Return code: 0 21:58:31 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:58:31 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:58:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:58:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:58:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:58:31 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/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 21:58:31 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/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost 21:58:31 INFO - Using env: {'DISPLAY': ':0', 21:58:31 INFO - 'HOME': '/home/cltbld', 21:58:31 INFO - 'LANG': 'en_US.UTF-8', 21:58:31 INFO - 'LANGUAGE': 'en_US:en', 21:58:31 INFO - 'LOGNAME': 'cltbld', 21:58:31 INFO - 'MAIL': '/var/mail/cltbld', 21:58:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:58:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:58:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:58:31 INFO - 'MOZ_NO_REMOTE': '1', 21:58:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:58:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:58:31 INFO - 'NO_EM_RESTART': '1', 21:58:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:58:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:58:31 INFO - 'PWD': '/builds/slave/test-pgo', 21:58:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:58:31 INFO - 'SHELL': '/bin/bash', 21:58:31 INFO - 'SHLVL': '1', 21:58:31 INFO - 'TERM': 'linux', 21:58:31 INFO - 'TMOUT': '86400', 21:58:31 INFO - 'USER': 'cltbld', 21:58:31 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1447826149.898596-1319257888', 21:58:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:58:31 INFO - '_': '/tools/buildbot/bin/python'} 21:58:31 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/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost'] with output_timeout 3600 21:58:31 INFO - mozversion INFO | application_buildid: 20151117203118 21:58:31 INFO - mozversion INFO | application_changeset: 6fa3b2df62cc80058ea2f63834dcbdd6ec7caa36 21:58:31 INFO - mozversion INFO | application_display_name: Nightly 21:58:31 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:58:31 INFO - mozversion INFO | application_name: Firefox 21:58:31 INFO - mozversion INFO | application_remotingname: firefox 21:58:31 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 21:58:31 INFO - mozversion INFO | application_vendor: Mozilla 21:58:31 INFO - mozversion INFO | application_version: 45.0a1 21:58:31 INFO - mozversion INFO | platform_buildid: 20151117203118 21:58:31 INFO - mozversion INFO | platform_changeset: 6fa3b2df62cc80058ea2f63834dcbdd6ec7caa36 21:58:31 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 21:58:31 INFO - mozversion INFO | platform_version: 45.0a1 21:58:31 INFO - 2015-11-17 21:58:31,673 DEBUG : using testdate: 1447826311 21:58:31 INFO - 2015-11-17 21:58:31,673 DEBUG : actual date: 1447826311 21:58:31 INFO - 2015-11-17 21:58:31,690 INFO : starting webserver on 'localhost:56924' 21:58:31 INFO - 2015-11-17 21:58:31,691 INFO : Starting test suite talos-linux64-ix-041.e 21:58:31 INFO - 2015-11-17 21:58:31,691 INFO : Starting test dromaeo_css 21:58:31 INFO - 2015-11-17 21:58:31,691 DEBUG : operating with platform_type : linux_ 21:58:31 INFO - 2015-11-17 21:58:31,691 INFO : Initialising browser for dromaeo_css test... 21:58:31 INFO - 2015-11-17 21:58:31,708 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpepGDgi/profile http://localhost:56924/getInfo.html 21:58:37 INFO - 2015-11-17 21:58:37,111 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:58:37 INFO - 2015-11-17 21:58:37,112 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:58:37 INFO - 2015-11-17 21:58:37,112 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:58:37 INFO - 2015-11-17 21:58:37,112 DEBUG : BROWSER_OUTPUT: __metrics 21:58:38 INFO - 2015-11-17 21:58:38,228 INFO : Browser initialized. 21:58:38 INFO - 2015-11-17 21:58:38,229 INFO : Running cycle 1/1 for dromaeo_css test... 21:58:38 INFO - 2015-11-17 21:58:38,229 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpepGDgi/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:58:50 INFO - 2015-11-17 21:58:50,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 141393920 21:58:50 INFO - 2015-11-17 21:58:50,005 DEBUG : BROWSER_OUTPUT: 21:59:39 INFO - 2015-11-17 21:59:39,623 DEBUG : BROWSER_OUTPUT: 1447826379620 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] 22:01:47 INFO - 2015-11-17 22:01:47,989 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56924/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56924/tests/dromaeo/cssquery-ext.html) 22:01:49 INFO - 2015-11-17 22:01:49,086 DEBUG : BROWSER_OUTPUT: RSS: Main: 148054016 22:01:49 INFO - 2015-11-17 22:01:49,086 DEBUG : BROWSER_OUTPUT: 22:04:50 INFO - 2015-11-17 22:04:50,970 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56924/tests/dromaeo/cssquery-ext.html (next: http://localhost:56924/tests/dromaeo/cssquery-jquery.html) 22:04:51 INFO - 2015-11-17 22:04:51,564 DEBUG : BROWSER_OUTPUT: RSS: Main: 140754944 22:04:51 INFO - 2015-11-17 22:04:51,564 DEBUG : BROWSER_OUTPUT: 22:07:53 INFO - 2015-11-17 22:07:53,209 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56924/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56924/tests/dromaeo/cssquery-mootools.html) 22:07:53 INFO - 2015-11-17 22:07:53,790 DEBUG : BROWSER_OUTPUT: RSS: Main: 141742080 22:07:53 INFO - 2015-11-17 22:07:53,790 DEBUG : BROWSER_OUTPUT: 22:10:55 INFO - 2015-11-17 22:10:55,460 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56924/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56924/tests/dromaeo/cssquery-prototype.html) 22:10:56 INFO - 2015-11-17 22:10:56,060 DEBUG : BROWSER_OUTPUT: RSS: Main: 140308480 22:10:56 INFO - 2015-11-17 22:10:56,060 DEBUG : BROWSER_OUTPUT: 22:13:58 INFO - 2015-11-17 22:13:58,327 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56924/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56924/tests/dromaeo/cssquery-yui.html) 22:13:58 INFO - 2015-11-17 22:13:58,908 DEBUG : BROWSER_OUTPUT: RSS: Main: 141611008 22:13:58 INFO - 2015-11-17 22:13:58,908 DEBUG : BROWSER_OUTPUT: 22:17:01 INFO - 2015-11-17 22:17:01,234 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56924/tests/dromaeo/cssquery-yui.html (next: http://localhost:56924/tests/dromaeo/cssquery-dojo.html) 22:17:01 INFO - 2015-11-17 22:17:01,484 DEBUG : BROWSER_OUTPUT: RSS: Main: 143974400 22:17:01 INFO - 2015-11-17 22:17:01,484 DEBUG : BROWSER_OUTPUT: 22:17:01 INFO - 2015-11-17 22:17:01,486 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:17:01 INFO - 2015-11-17 22:17:01,486 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:17:01 INFO - 2015-11-17 22:17:01,486 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:17:01 INFO - 2015-11-17 22:17:01,487 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:17:01 INFO - 2015-11-17 22:17:01,490 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3222.8710851565934;3269.3134441767243;3301.356235534072;3303;3316.436205845006;5251.291075704778;5274.73626318684;5310.787568497255;5324.62727609067;5382.703951282683;5317.46825317468;5335.466453354663;5352.464753524646;5403.162509810976;5420.403755586883;4879.512048795127;4895.216765317541;4967.801287948478;4980.27785971034;5017.247412888078;4988.850334489971;5014.147594908856;5014.423341315759;5035.697858128506;5054.974725126369;4783.1868582341085;4851.757412129379;4946.258061290817;4975.427825800007;4989.401271847401;4849.563539281482;4854.684445511066;4857;4871.050145221683;4883.365162528884;4782.545658162504;4852.878678033042;4862.708237505725;4863.27050942358;4877.756112194412;5133.383993920716;5204.76578553966;5214.035403450373;5221.112410890158;5233.633645644806;5785.218995435646;5790.392008839053;5796.536277097822;5799.159121927339;5804.65172089676;5726.484616384504;5817.447342502455;5851;5852.209951656514;5879.735411906475;5353.866153346197;5516.613837031409;5540.639858409231;5541.612087153901;5546.889062218774;5778.104393818965;5852.063669812809;5945.910811337833;5951.166836642873;5963.224780778471;5719.5138413235345;5757.366689664133;5760.308762948389;5773.538116950634;5781.219535362757;5650.5479561634975;5788.710564471844;5789.768409263583;5801;5814.447627475383;5751.22358481608;5759.510441612426;5763.740631671585;5765.654060756368;5810.477057064884;5703.74333155009;5715.599908006399;5752.453516915886;5765.798197063166;5774.39368866263;4347.7173983690955;4395.406620106309;4430.689851710349;4468.352088947085;4469.575390337913;4023.0746928206677;4047.2310261050893;4051.1897620476025;4051.2910240707756;4095.651869591118;5551.639143455663;5577.414371491016;5580.944190558123;5588.944110558842;5626.212330273765;5635.408282130399;5700.458456446631;5720.628159169641;5762.971185144132;5826.563007774434;5605.383407825136;5622.493975542221;5623.578231632644;5626.521745651666;5635.098384258581;4978.975105124451;5087.720175390389;5093.159628661229;5111.616628752784;5154;5937.2578427696535;5988.610740301867;6014.097885317325;6100.908486372708;6139.877202455926;5801;5802.0426629605645;5809.883802324014;5825.213596164633;5860.472557469848;5845.298564172326;5907.793227237026;6029.487493563096;6034.39656034393;6053.969730151321;5645.633033852787;5693.117566777156;5698.373178950395;5699;5712.857178570569;5868.501177399969;5921.259842519685;5932.16949627044;5959.046552551571;5962.4633782959745;5486.478784515464;5620.241267428844;5768.394318596487;5786.739596718242;5814.796482123105;5669.688167150846;5671.234383358359;5679.630823996427;5685.630434021776;5774.39368866263;5577.6653400796085;5578.135389014709;5580.972095139498;5581.776728930798;5589.888202236014;5554.416786237387;5665.065264231355;5681.261436013292;5685.971570142288;5782.277215348082;5595.860103497445;5615.606907516598;5617.859553511032;5623.662580245198;5628.802991895264 22:17:01 INFO - 2015-11-17 22:17:01,492 DEBUG : BROWSER_OUTPUT: |1;ext.html;568.8122919436586;604.8276241271238;611.6880391000591;628.6605233174087;630.0486265738733;38358;39497.21005579894;39508.40737388938;39509.20981580374;39536;42132;42568.78715606425;42858.57141428593;42863.78568107155;42932.35601465973;8632.870506942401;8694.521801300925;8785.121487851227;8787.736367908972;8795.120487951186;8407.95796021022;8459.746207613782;8557.315414766836;8565.571721413935;8604.311655067611;8383.077861435268;8455.53494557799;8455.788605284855;8461.746147615582;8470.28002619775;8608.182222688834;8694.826103477895;8701.260392866614;8717.171868672465;8735.432196907212;8535.061143274235;8564.229219370287;8666.046734859161;8668.133186681282;8684.305255579538;39456.21087578261;39528.80235598832;39812.20375592501;39827.601723982676;39861.00347491307;2924.3274046969104;3213.962805149135;3281.950770738441;3413.3173365326784;3898.298306304864;29314.657825249735;29394.559081613792;29690.851545742134;29769.553456698166;30159.69840301613;3275.96724032759;3366.1248075500303;3389.983050084734;3485.076454739496;3502.544669193014;266888;268230.65884670644;268423;268786;268804.999999998;42891.57108428938;43285.78357108194;43643.34534981978;57364.71317643385;57585;42330.78834605807;42333.36499952503;42402.36396454056;42475.05349251107;42775.7861210692;13324.533641322507;13414;13456.25990570528;13458.259795711134;13467.595972120853;10707.089897358812;10755.56977720898;10795.136389088853;10818.188635852342;10824.18818588609;14499.710005799825;14604.780928286084;14623.634409139857;14652.12087274767;14733.55799326022;5881.735321910524;6013.729382177812;6014.218151640259;6082.422169893853;6094.116353128771;851.880736696863;881.2113158722907;946.5172761891484;969.6412327438893;1007.3452256033637;28648.85675571609;29256.7074329254;29336.413271734447;32051.51922721161;32818.83590582032;949.2216382566229;1045.5086109528509;1068.9203904056958;1106.651404807483;1157.9652610421701;14849.628759281104;15169.469068582546;15217.239138043275;15345;15467.458638947808;376118;377869;381333;382217;382925;52810;53438.73280633572;53497.46502534925;53657.73171134119;53913.191302129715;1223.5472875036294;1319.9340032998505;1320.4982106799162;1338.4980632262902;1367.2206842099908;27696.584551231346;28416.857915711116;28733.28166795847;28987.56518652264;29074.854625726737;45958;46241.76879115583;46456;46628;46693.76653116713;297670;298045;298562;299453;300298;32187.67812321847;46129.077418452114;46184;46323.53676463327;46834.29748553706;42991.785041074596;43030.35454468248;43087.784561078246;43487;44129.77935110304;36188;36575.08562285964;40342.79828600838;41625.37561936634;41720.79139604283;37086.11897174563;37301.253974920895;37482.812585936896;37503.43744843884;37794.433083503216;35516;35960.28079438449;36471.27057458889;36553.81723091367;36681.63318366782;32276.677233228307;34301.65698342985;34496.655033449344;34603.30793384169;42682.78658606687;29995.700043000164;30484.237894052825;31002;32470;34262.31475370429 22:17:01 INFO - 2015-11-17 22:17:01,495 DEBUG : BROWSER_OUTPUT: |2;jquery.html;356.16834690996507;359.80570491934355;362.31341607653496;362.54319557357724;364.3623658597455;12476.563320283769;12776.808347874767;16663.166841657912;17392.217350219238;18113.728294075583;11817.231879927798;11893.583724569642;11956.701082472942;12024.158308918379;12189.781021897807;4454.220511410506;4527.4340707411575;4536.9092618147615;4567.246404343296;4569;4799.904001919959;4898.387701537308;4902.730349830758;4906.877328066809;4914.066327397783;4608.654350923677;4686.929696054562;4727.196376615966;4856.198727210024;4867.780949857265;4647.326137710047;4714.976425117887;4754.833580824689;4756.120117778205;4761.880952976186;4321.481422229321;4345.174416860787;4375.387445757597;4395.230834603932;4400.295952647593;13623.523176688868;13838.861611383958;13895.722085558333;14401.063930844462;14487.710245795026;1848.122141982561;1957.725918371415;1972.753405824272;1976.495993521657;1996.2414282572674;10195.694129176136;10324.174066074696;10411.739706507322;10488.947555262252;10560.841587376195;1738.391562952969;1743.4333841501436;1762.9911850440665;1769.3630293094475;1783.7301883878179;60364.69817650928;61404.999999999556;61985.38014619886;62468;63275.36724632787;7178.856422871513;7255.782326530212;7277.2722727726805;7288.125424948934;7313.670884810196;8527.616257268437;8543.658253669908;8543.786405339917;8549.316054715608;8560.571971401405;5544.528715059265;5580.386157522669;5585.245991791137;5602.243697100921;5614.9157762633595;5731.570132240098;5736.340320863071;5742.109972954116;5750.079987202028;5770.740316685759;3324.9002529923655;3327.8169700666213;3343.5653365062385;3348.079278198515;3377.2401209727614;1157.2535714464123;1167.6030149748956;1186.9169158158845;1189.2983139947473;1194.319238034312;402.86705387222145;420.690792267683;423.860126158367;450.4864454521848;452.6311056488951;10633.149348052137;10874;10883.401412922207;10911.781764364669;11002.559897604006;420.18274456182434;423.1536926147705;431.6676159357277;434.6631360695486;443.3327841598374;5896.528277737771;6528.445082167974;6690.397864192246;6857.2114206866845;6875.209350924708;521278;521657;529414;531072;532796;72046;76016;76830;76915.61542192253;79369.60315198387;566.3600131850982;574.3395095640047;578.0721941284262;578.6846168837993;578.774278031568;10894.61868834587;11450;11572.36352000648;11748.530058797553;11917.106217033584;32953;33549.83225083859;33636.831815840764;33745.83127084349;34409.139771505914;46149.76925115353;46899.765501172275;47131.764341178074;47429.288560670924;47447;6413.0701048348665;6589.934100659124;6599.340065993362;6743.325667433413;6860.759873404407;12068.275903445821;12282.570110046105;12385.504579816707;12464.626061218178;12508.437120329425;10578.100861426557;10891.455427228766;10966.451677416257;10992.340459572451;11003.064739496913;10407.68776936693;10718.24972251935;10857.511411986321;10878;10881.129509639051;10841.07850832688;10903.618373356894;10971.561137554727;11083.168762342695;11130;6413.454856337264;6422.839429014312;6464.997925321582;6465.579737317059;6485.578437401554;11116.49975751077;11237.831432528683;11248.043916267208;11424.771504569695;11465.598704045318 22:17:01 INFO - 2015-11-17 22:17:01,496 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1488.397199134351;1714.982850171498;1747.2224859937332;1755.9385421510249;1786.231920274282;7424.294692004264;7716.884246736304;7737.148913619498;7898.407619428537;7934.9603251983735;8006.639701213445;8046.798830029237;8080.919190808105;8102.473339232945;8112.351011919047;2266.977330226697;2295.4031951692596;2296.0700916128994;2296.2881506732883;2302.297799171252;2298.425393651587;2328.0338659456306;2345.929622111331;2346.4133966508375;2349.119080344871;2191.2221161487682;2235.4634887626935;2237.272886311947;2264.388615073929;2283.954320913581;2220.844540882139;2239.4177513846353;2298.8505747126383;2305.1010106058734;2315.178111770331;2303.009705826494;2324.9070037198494;2327.197116994634;2331.160782118436;2336.6027775278244;7869.252421019994;7943.046834379911;7954.721584744506;7965.920340796576;7966.760997170094;4696.201645720202;4768.427788665383;4781.569658730697;4829.589484893788;4839.637027222937;3046.7257946784675;3048.7103725146076;3092.1496588438135;3093.180307218589;3123.859426325821;1025.0710752330715;1036.0623635609786;1055.3404122423485;1081.3674000709593;1924.5573518090916;10855.40295283759;10894.237403381687;10895;10915.83626245599;10948.835767463494;4145.937810932838;4228.936565951513;4337.891552711208;4443.155800397914;4515.571020753023;8646.394752367274;8810.207081362709;8818.559072046372;8827;8827.205551500396;4806.855794326176;4816.8314109006715;4817.975910120427;4827.058723548945;4835.95164048355;4365.257906155961;4386.846460373936;4388.978055109704;4389.144116897174;4418.359337896051;3487.3548393547276;3492.388831954398;3530.6822385985383;3541.4156664150128;3546;1062.8990245926625;1064.8722153341648;1069.096613361708;1070.5878236878857;1076.4832880217539;1006.2654262388497;1013.5287091502487;1071.528527447936;1159.5477763672175;1321.4648067532664;7380.114386273682;7470.103587569526;7487.47587668858;7530.698772049166;7539.73610923626;1141.9094764499882;1149.9770004599861;1159.7274640459486;1170.2861254634665;1174.7356844710043;5864.648121112747;5875.676837773964;5891.381404952418;5899.646021238739;5922.318933322636;9178.632854685871;9573.569189386495;9584.233261339075;9713.660021899199;9766.218702503782;9436.575354109082;9456.669016584525;9502;9518;9608.9039109608;7201.207867134611;7396.0754905636795;7423.62881855905;7438.851222975511;7498.4376171787335;7032.26161253061;7081.645917704197;7091.9290807091265;7095.077639906779;7137.571745695275;8132.959335203286;8251.876221856557;8349.95825020871;8351.20663536963;8444.915550844413;8279.420440569102;8553.187447192755;8562.229399354088;8632.78418039554;8729.476231426135;6910.2398736137975;6989.8951515726285;7022;7025.68384422692;7033.191183014019;7679.462437629312;7733.149353570991;7760.456768026184;7767.145613982344;7801;7059;7218.927810721825;7268.600226987566;7407.59258240802;7416.480846340704;6579.901301480578;6623.966880165568;6963.477739169683;7049.823754406181;7300.12398512182;7192;7243.5653860768525;7271.2365201653065;7274.527155734861;7292.96353518229;6468.191476065492;6694.799156025327;6695.330466953461;6711.731530738911;6712.026756120237;6618.305077966937;6652.667366631746;6694.230163531061;6695;6698.732050718112 22:17:01 INFO - 2015-11-17 22:17:01,500 DEBUG : BROWSER_OUTPUT: |4;prototype.html;334.8141781311371;343.73360645499736;345.4938515075414;347.6245654692931;351.21678656595793;6228.968855155729;6230.439260466557;6248.687565621718;6249.093881387207;6435.774747883825;6193.411625895544;6202.4417802397775;6221.688915554227;6259;6304.054391841215;4743.075100355432;4755.619550435957;4776.211925032366;4780.426348838136;4785.71285722856;4739.6208303335825;4750.026244619845;4774.092922344761;4780.976095119519;4786.976065119669;4651.093036857814;4669.976650116745;4724.976375118137;4742.288656701505;4778.163821331271;4744.596709279698;4754;4785.042991401699;4785.904281914377;4789.257665061904;4181.97909010453;4204.747715137101;4209.810558524874;4217.156568686275;4227;5916.290045194562;5951.791687290967;5955.880882382371;5961.314448838396;5967.254093238345;5454.672719636835;5567.805126820583;5576.275084239023;5577.8047768327915;5590.944090559083;6564.638944858031;6593.505487088488;6622.403983641495;6624.668766561653;6632.966835165842;4647.34937108805;4658.231391820379;4661.417322834645;4664.603508701764;4665.766711664403;6765.560238584476;6805.48958828085;6873.037774711544;6882.070920425728;6883.724651013953;4797.592204662573;4799.688020278671;4806.7836947337455;4806.855794326176;4808.158572249842;4874.8781280467565;4877.146499362598;4880.365552478155;4883.58489528387;4891.144049791273;5574.58190635704;5583.748731307101;5591.720413979285;5601.775928962796;5604.803831865946;6620.867582648417;6650.900236496456;6685.264620891698;6702.329767023259;6721.294264102199;1703.276107654242;1718.7164117920404;1722.0872937343229;1731.480555833245;1737.695903216932;1170.4791367841399;1170.8770579089073;1179.6402097360217;1184.4137152109588;1189.5241903238773;6460.676966151674;6474.546781725234;6477.093206951031;6479.967600161969;6482.481401487869;6864.1762988440705;6866.313368663194;6877.724891004404;6893.7931862044215;6909.2745261746795;6316.589421687668;6414.422701956846;6420.807375778734;6462.450691691259;6558.704858281389;3771.283456143324;3777.622237776255;3778.848846046182;3780.527434070741;3801.334766415866;7247.23903990084;7298.306660867209;7313.341799238094;7317.231690672509;7317.963410183022;6977.162740471074;7141.14306283239;7181.138263408425;7189.964050179716;7207.855842883113;7227.9638601806655;7272.745453909193;7284.745033923788;7286.890696639554;7291.0157128788;6934.375906168469;6936.930630693629;6984.895226571504;6988.965055174692;6993.895091573529;6742.056112144402;6831.180258369028;6863.553868998499;6907.930920690729;6911.067005954333;7226.385757210696;7268.9273107270365;7278.963605182152;7283.380912622486;7309.195988441374;4662.696924699883;4702.435707715096;4714.858554243378;4715.12770137512;4725.125851717443;6701.229358623821;6857.451403887577;6909.619970901648;6933.064036355229;6988;6711.194656641039;6732.663366831541;6741.157355330583;6753.527253092237;6755.1556055493065;6680.131582894387;6743.15710536183;6751.358620931003;6752.527323087336;6770.4922130839395;6463.870722585616;6599.868002639824;6618.801435956929;6640.335966403321;6660.400563949268;6755.729770809113;6786.8642627148165;6795.218549866829;6799.524033317621;6819.659017049227;6485.902711459237;6598.241202261801;6627.204735431779;6628.668566571749;6629.138212032405 22:17:01 INFO - 2015-11-17 22:17:01,501 DEBUG : BROWSER_OUTPUT: |5;yui.html;846.991530084699;855.1106848877168;860.1785295043235;875.8905136857893;882.8719835623834;13234.669133271662;14554.19951902645;14590.78113828292;14656.706865862676;14673.486427975024;13653.590392288223;13747.793783093262;13843.515476958308;13851.099678520914;13860.4455821767;799.7800604833689;814.5072231300067;815.6981916690803;822.0751654388813;828.7140936376941;813.3208770676492;814.5316443045243;819.8196396792725;822.4160845799489;823.4894365493402;829.2205326992638;840.2143995364323;842.3135144856922;844.5397258494105;845.2012847858776;825.4345773145415;827.8385714785619;830.9626066826977;835.9582020898931;837.3970741066422;610.3957082488305;611.0437165835453;611.9321783487842;611.9755209791603;613.0008086818502;13281.667958301023;13355.465781368734;13376.799348009788;13404;13414.798778018338;9894.802103957953;10560.155187585051;10562.419066951315;10628.043476087112;10683.83974240387;9585.712428627152;9754.561044753003;9787.314887957775;9890.15933645641;10203.540840662188;3177.809331440121;3192.409404260196;3236.2394837213237;3298.538204651351;3313.2545177335146;42199.9450013749;42650.933726656775;43261.783691081655;43264;43547;6813.454923606099;6843.349881761224;6898.1377327834025;7028.367446929801;7032.789016329519;10829.458527073615;10915.945420273007;10918.399488028075;10922.890771092347;10984.395858227714;6350.206224221973;6401.943679292957;6430.614163150226;6487.513436492282;6498.057781621638;4121.876343709693;4180.749155050707;4206.68172725734;4269.359596060615;4304.5480224576595;2651.946961060768;2690;2708.8916443342046;2709.539378305693;2713.6743590769233;420.6214407033633;468.5829611645638;477.3150528990909;482.1682597519321;484.7091744953;573.7934343636288;626.8244891430406;636.6307541625846;649.9545031847725;674.5514233035075;8579;8759.080296568896;9027.864582031274;9495.14543691071;9505.477198753997;674.1909708349901;680.6596701649175;690.5821977703417;702.4871843554234;704.7005022865262;4039.7576145431367;4104.91790164195;4264.488261408589;4283.528811830696;4288.978555107205;58048.4195158043;58345.41654583485;58842;58863;59352.10971835426;53044.73477632587;53356;53651.46348536543;53802.73098634482;54010;45469.317960230626;45515;46211.53788462139;47684.284735729685;49064.7546762271;8833.160849719266;8850.557472126238;9270.44377337362;9295;9417.717468475958;32836.01491955245;33945;34009.149771255914;34624.82687586546;34760.478592820626;41313.79343103265;43098;44187.55812441834;44709.10581788411;44849.55150448584;8610.268127209258;8758.299336053227;8760.080191580048;8774.736757897273;8780.780480487783;12350.258984460961;12516.87483125157;12519.874801251872;13059.412326445523;13209.405576748877;10913.945430272797;11098.500567474644;11497.425128743362;11604;11899.226550274205;11236.97507494477;11529.654110376701;11563.768724625292;11566.595169169039;11916.285022898654;10448.065679810921;10640.52117654692;11052.723681907695;11290.096792256763;11504;10043.89956100459;10184.439855808001;10214.54034568461;10396.376217426978;10801.567937282422;9186.173244408035;9436.811263774824;9768.902310977084;9980.151687106678;10043.548040338057 22:17:01 INFO - 2015-11-17 22:17:01,502 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:17:01 INFO - 2015-11-17 22:17:01,502 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:17:01 INFO - 2015-11-17 22:17:01,502 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,287 22:17:01 INFO - 2015-11-17 22:17:01,503 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:17:01 INFO - 2015-11-17 22:17:01,503 DEBUG : BROWSER_OUTPUT: __startTimestamp1447827421485__endTimestamp 22:17:01 INFO - 2015-11-17 22:17:01,503 DEBUG : BROWSER_OUTPUT: 22:17:01 INFO - 2015-11-17 22:17:01,503 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:17:01 INFO - 2015-11-17 22:17:01,504 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:17:01 INFO - 2015-11-17 22:17:01,504 DEBUG : BROWSER_OUTPUT: 22:17:01 INFO - 2015-11-17 22:17:01,504 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5394.44 Median:5623.58 stddev:594.01 (10.6%) stddev-sans-first:570.88 22:17:01 INFO - 2015-11-17 22:17:01,505 DEBUG : BROWSER_OUTPUT: Values: 3222.9 3269.3 3301.4 3303.0 3316.4 5251.3 5274.7 5310.8 5324.6 5382.7 5317.5 5335.5 5352.5 5403.2 5420.4 4879.5 4895.2 4967.8 4980.3 5017.2 4988.9 5014.1 5014.4 5035.7 5055.0 4783.2 4851.8 4946.3 4975.4 4989.4 4849.6 4854.7 4857.0 4871.1 4883.4 4782.5 4852.9 4862.7 4863.3 4877.8 5133.4 5204.8 5214.0 5221.1 5233.6 5785.2 5790.4 5796.5 5799.2 5804.7 5726.5 5817.4 5851.0 5852.2 5879.7 5353.9 5516.6 5540.6 5541.6 5546.9 5778.1 5852.1 5945.9 5951.2 5963.2 5719.5 5757.4 5760.3 5773.5 5781.2 5650.5 5788.7 5789.8 5801.0 5814.4 5751.2 5759.5 5763.7 5765.7 5810.5 5703.7 5715.6 5752.5 5765.8 5774.4 4347.7 4395.4 4430.7 4468.4 4469.6 4023.1 4047.2 4051.2 4051.3 4095.7 5551.6 5577.4 5580.9 5588.9 5626.2 5635.4 5700.5 5720.6 5763.0 5826.6 5605.4 5622.5 5623.6 5626.5 5635.1 4979.0 5087.7 5093.2 5111.6 5154.0 5937.3 5988.6 6014.1 6100.9 6139.9 5801.0 5802.0 5809.9 5825.2 5860.5 5845.3 5907.8 6029.5 6034.4 6054.0 5645.6 5693.1 5698.4 5699.0 5712.9 5868.5 5921.3 5932.2 5959.0 5962.5 5486.5 5620.2 5768.4 5786.7 5814.8 5669.7 5671.2 5679.6 5685.6 5774.4 5577.7 5578.1 5581.0 5581.8 5589.9 5554.4 5665.1 5681.3 5686.0 5782.3 5595.9 5615.6 5617.9 5623.7 5628.8 22:17:01 INFO - 2015-11-17 22:17:01,506 DEBUG : BROWSER_OUTPUT: 22:17:01 INFO - 2015-11-17 22:17:01,506 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48044.89 Median:210641.50 stddev:83727.63 (39.7%) stddev-sans-first:83886.63 22:17:01 INFO - 2015-11-17 22:17:01,509 DEBUG : BROWSER_OUTPUT: Values: 568.8 604.8 611.7 628.7 630.0 38358.0 39497.2 39508.4 39509.2 39536.0 42132.0 42568.8 42858.6 42863.8 42932.4 8632.9 8694.5 8785.1 8787.7 8795.1 8408.0 8459.7 8557.3 8565.6 8604.3 8383.1 8455.5 8455.8 8461.7 8470.3 8608.2 8694.8 8701.3 8717.2 8735.4 8535.1 8564.2 8666.0 8668.1 8684.3 39456.2 39528.8 39812.2 39827.6 39861.0 2924.3 3214.0 3282.0 3413.3 3898.3 29314.7 29394.6 29690.9 29769.6 30159.7 3276.0 3366.1 3390.0 3485.1 3502.5 266888.0 268230.7 268423.0 268786.0 268805.0 42891.6 43285.8 43643.3 57364.7 57585.0 42330.8 42333.4 42402.4 42475.1 42775.8 13324.5 13414.0 13456.3 13458.3 13467.6 10707.1 10755.6 10795.1 10818.2 10824.2 14499.7 14604.8 14623.6 14652.1 14733.6 5881.7 6013.7 6014.2 6082.4 6094.1 851.9 881.2 946.5 969.6 1007.3 28648.9 29256.7 29336.4 32051.5 32818.8 949.2 1045.5 1068.9 1106.7 1158.0 14849.6 15169.5 15217.2 15345.0 15467.5 376118.0 377869.0 381333.0 382217.0 382925.0 52810.0 53438.7 53497.5 53657.7 53913.2 1223.5 1319.9 1320.5 1338.5 1367.2 27696.6 28416.9 28733.3 28987.6 29074.9 45958.0 46241.8 46456.0 46628.0 46693.8 297670.0 298045.0 298562.0 299453.0 300298.0 32187.7 46129.1 46184.0 46323.5 46834.3 42991.8 43030.4 43087.8 43487.0 44129.8 36188.0 36575.1 40342.8 41625.4 41720.8 37086.1 37301.3 37482.8 37503.4 37794.4 35516.0 35960.3 36471.3 36553.8 36681.6 32276.7 34301.7 34496.7 34603.3 42682.8 29995.7 30484.2 31002.0 32470.0 34262.3 22:17:01 INFO - 2015-11-17 22:17:01,509 DEBUG : BROWSER_OUTPUT: 22:17:01 INFO - 2015-11-17 22:17:01,510 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26574.56 Median:2376.57 stddev:86458.36 (3637.9%) stddev-sans-first:86678.49 22:17:01 INFO - 2015-11-17 22:17:01,510 DEBUG : BROWSER_OUTPUT: Values: 356.2 359.8 362.3 362.5 364.4 12476.6 12776.8 16663.2 17392.2 18113.7 11817.2 11893.6 11956.7 12024.2 12189.8 4454.2 4527.4 4536.9 4567.2 4569.0 4799.9 4898.4 4902.7 4906.9 4914.1 4608.7 4686.9 4727.2 4856.2 4867.8 4647.3 4715.0 4754.8 4756.1 4761.9 4321.5 4345.2 4375.4 4395.2 4400.3 13623.5 13838.9 13895.7 14401.1 14487.7 1848.1 1957.7 1972.8 1976.5 1996.2 10195.7 10324.2 10411.7 10488.9 10560.8 1738.4 1743.4 1763.0 1769.4 1783.7 60364.7 61405.0 61985.4 62468.0 63275.4 7178.9 7255.8 7277.3 7288.1 7313.7 8527.6 8543.7 8543.8 8549.3 8560.6 5544.5 5580.4 5585.2 5602.2 5614.9 5731.6 5736.3 5742.1 5750.1 5770.7 3324.9 3327.8 3343.6 3348.1 3377.2 1157.3 1167.6 1186.9 1189.3 1194.3 402.9 420.7 423.9 450.5 452.6 10633.1 10874.0 10883.4 10911.8 11002.6 420.2 423.2 431.7 434.7 443.3 5896.5 6528.4 6690.4 6857.2 6875.2 521278.0 521657.0 529414.0 531072.0 532796.0 72046.0 76016.0 76830.0 76915.6 79369.6 566.4 574.3 578.1 578.7 578.8 10894.6 11450.0 11572.4 11748.5 11917.1 32953.0 33549.8 33636.8 33745.8 34409.1 46149.8 46899.8 47131.8 47429.3 47447.0 6413.1 6589.9 6599.3 6743.3 6860.8 12068.3 12282.6 12385.5 12464.6 12508.4 10578.1 10891.5 10966.5 10992.3 11003.1 10407.7 10718.2 10857.5 10878.0 10881.1 10841.1 10903.6 10971.6 11083.2 11130.0 6413.5 6422.8 6465.0 6465.6 6485.6 11116.5 11237.8 11248.0 11424.8 11465.6 22:17:01 INFO - 2015-11-17 22:17:01,510 DEBUG : BROWSER_OUTPUT: 22:17:01 INFO - 2015-11-17 22:17:01,510 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5538.44 Median:6524.05 stddev:2852.17 (43.7%) stddev-sans-first:2843.92 22:17:01 INFO - 2015-11-17 22:17:01,511 DEBUG : BROWSER_OUTPUT: Values: 1488.4 1715.0 1747.2 1755.9 1786.2 7424.3 7716.9 7737.1 7898.4 7935.0 8006.6 8046.8 8080.9 8102.5 8112.4 2267.0 2295.4 2296.1 2296.3 2302.3 2298.4 2328.0 2345.9 2346.4 2349.1 2191.2 2235.5 2237.3 2264.4 2284.0 2220.8 2239.4 2298.9 2305.1 2315.2 2303.0 2324.9 2327.2 2331.2 2336.6 7869.3 7943.0 7954.7 7965.9 7966.8 4696.2 4768.4 4781.6 4829.6 4839.6 3046.7 3048.7 3092.1 3093.2 3123.9 1025.1 1036.1 1055.3 1081.4 1924.6 10855.4 10894.2 10895.0 10915.8 10948.8 4145.9 4228.9 4337.9 4443.2 4515.6 8646.4 8810.2 8818.6 8827.0 8827.2 4806.9 4816.8 4818.0 4827.1 4836.0 4365.3 4386.8 4389.0 4389.1 4418.4 3487.4 3492.4 3530.7 3541.4 3546.0 1062.9 1064.9 1069.1 1070.6 1076.5 1006.3 1013.5 1071.5 1159.5 1321.5 7380.1 7470.1 7487.5 7530.7 7539.7 1141.9 1150.0 1159.7 1170.3 1174.7 5864.6 5875.7 5891.4 5899.6 5922.3 9178.6 9573.6 9584.2 9713.7 9766.2 9436.6 9456.7 9502.0 9518.0 9608.9 7201.2 7396.1 7423.6 7438.9 7498.4 7032.3 7081.6 7091.9 7095.1 7137.6 8133.0 8251.9 8350.0 8351.2 8444.9 8279.4 8553.2 8562.2 8632.8 8729.5 6910.2 6989.9 7022.0 7025.7 7033.2 7679.5 7733.1 7760.5 7767.1 7801.0 7059.0 7218.9 7268.6 7407.6 7416.5 6579.9 6624.0 6963.5 7049.8 7300.1 7192.0 7243.6 7271.2 7274.5 7293.0 6468.2 6694.8 6695.3 6711.7 6712.0 6618.3 6652.7 6694.2 6695.0 6698.7 22:17:01 INFO - 2015-11-17 22:17:01,512 DEBUG : BROWSER_OUTPUT: 22:17:01 INFO - 2015-11-17 22:17:01,512 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5610.38 Median:6417.62 stddev:1695.57 (26.4%) stddev-sans-first:1653.45 22:17:01 INFO - 2015-11-17 22:17:01,513 DEBUG : BROWSER_OUTPUT: Values: 334.8 343.7 345.5 347.6 351.2 6229.0 6230.4 6248.7 6249.1 6435.8 6193.4 6202.4 6221.7 6259.0 6304.1 4743.1 4755.6 4776.2 4780.4 4785.7 4739.6 4750.0 4774.1 4781.0 4787.0 4651.1 4670.0 4725.0 4742.3 4778.2 4744.6 4754.0 4785.0 4785.9 4789.3 4182.0 4204.7 4209.8 4217.2 4227.0 5916.3 5951.8 5955.9 5961.3 5967.3 5454.7 5567.8 5576.3 5577.8 5590.9 6564.6 6593.5 6622.4 6624.7 6633.0 4647.3 4658.2 4661.4 4664.6 4665.8 6765.6 6805.5 6873.0 6882.1 6883.7 4797.6 4799.7 4806.8 4806.9 4808.2 4874.9 4877.1 4880.4 4883.6 4891.1 5574.6 5583.7 5591.7 5601.8 5604.8 6620.9 6650.9 6685.3 6702.3 6721.3 1703.3 1718.7 1722.1 1731.5 1737.7 1170.5 1170.9 1179.6 1184.4 1189.5 6460.7 6474.5 6477.1 6480.0 6482.5 6864.2 6866.3 6877.7 6893.8 6909.3 6316.6 6414.4 6420.8 6462.5 6558.7 3771.3 3777.6 3778.8 3780.5 3801.3 7247.2 7298.3 7313.3 7317.2 7318.0 6977.2 7141.1 7181.1 7190.0 7207.9 7228.0 7272.7 7284.7 7286.9 7291.0 6934.4 6936.9 6984.9 6989.0 6993.9 6742.1 6831.2 6863.6 6907.9 6911.1 7226.4 7268.9 7279.0 7283.4 7309.2 4662.7 4702.4 4714.9 4715.1 4725.1 6701.2 6857.5 6909.6 6933.1 6988.0 6711.2 6732.7 6741.2 6753.5 6755.2 6680.1 6743.2 6751.4 6752.5 6770.5 6463.9 6599.9 6618.8 6640.3 6660.4 6755.7 6786.9 6795.2 6799.5 6819.7 6485.9 6598.2 6627.2 6628.7 6629.1 22:17:01 INFO - 2015-11-17 22:17:01,513 DEBUG : BROWSER_OUTPUT: 22:17:01 INFO - 2015-11-17 22:17:01,514 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13342.96 Median:24076.43 stddev:15896.78 (66.0%) stddev-sans-first:15913.67 22:17:01 INFO - 2015-11-17 22:17:01,515 DEBUG : BROWSER_OUTPUT: Values: 847.0 855.1 860.2 875.9 882.9 13234.7 14554.2 14590.8 14656.7 14673.5 13653.6 13747.8 13843.5 13851.1 13860.4 799.8 814.5 815.7 822.1 828.7 813.3 814.5 819.8 822.4 823.5 829.2 840.2 842.3 844.5 845.2 825.4 827.8 831.0 836.0 837.4 610.4 611.0 611.9 612.0 613.0 13281.7 13355.5 13376.8 13404.0 13414.8 9894.8 10560.2 10562.4 10628.0 10683.8 9585.7 9754.6 9787.3 9890.2 10203.5 3177.8 3192.4 3236.2 3298.5 3313.3 42199.9 42650.9 43261.8 43264.0 43547.0 6813.5 6843.3 6898.1 7028.4 7032.8 10829.5 10915.9 10918.4 10922.9 10984.4 6350.2 6401.9 6430.6 6487.5 6498.1 4121.9 4180.7 4206.7 4269.4 4304.5 2651.9 2690.0 2708.9 2709.5 2713.7 420.6 468.6 477.3 482.2 484.7 573.8 626.8 636.6 650.0 674.6 8579.0 8759.1 9027.9 9495.1 9505.5 674.2 680.7 690.6 702.5 704.7 4039.8 4104.9 4264.5 4283.5 4289.0 58048.4 58345.4 58842.0 58863.0 59352.1 53044.7 53356.0 53651.5 53802.7 54010.0 45469.3 45515.0 46211.5 47684.3 49064.8 8833.2 8850.6 9270.4 9295.0 9417.7 32836.0 33945.0 34009.1 34624.8 34760.5 41313.8 43098.0 44187.6 44709.1 44849.6 8610.3 8758.3 8760.1 8774.7 8780.8 12350.3 12516.9 12519.9 13059.4 13209.4 10913.9 11098.5 11497.4 11604.0 11899.2 11237.0 11529.7 11563.8 11566.6 11916.3 10448.1 10640.5 11052.7 11290.1 11504.0 10043.9 10184.4 10214.5 10396.4 10801.6 9186.2 9436.8 9768.9 9980.2 10043.5 22:17:01 INFO - 2015-11-17 22:17:01,515 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:17:01 INFO - 2015-11-17 22:17:01,515 DEBUG : BROWSER_OUTPUT: 22:17:02 INFO - 2015-11-17 22:17:02,156 INFO : Browser exited with error code: 0 22:17:02 INFO - 2015-11-17 22:17:02,173 INFO : Completed test dromaeo_css (00:18:30) 22:17:02 INFO - 2015-11-17 22:17:02,173 INFO : Starting test kraken 22:17:02 INFO - 2015-11-17 22:17:02,173 DEBUG : operating with platform_type : linux_ 22:17:02 INFO - 2015-11-17 22:17:02,173 INFO : Initialising browser for kraken test... 22:17:02 INFO - 2015-11-17 22:17:02,179 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbCor6n/profile http://localhost:56924/getInfo.html 22:17:07 INFO - 2015-11-17 22:17:07,013 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:17:07 INFO - 2015-11-17 22:17:07,013 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:17:07 INFO - 2015-11-17 22:17:07,013 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:17:07 INFO - 2015-11-17 22:17:07,014 DEBUG : BROWSER_OUTPUT: __metrics 22:17:08 INFO - 2015-11-17 22:17:08,096 INFO : Browser initialized. 22:17:08 INFO - 2015-11-17 22:17:08,097 INFO : Running cycle 1/1 for kraken test... 22:17:08 INFO - 2015-11-17 22:17:08,097 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbCor6n/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:17:19 INFO - 2015-11-17 22:17:19,891 DEBUG : BROWSER_OUTPUT: RSS: Main: 141590528 22:17:19 INFO - 2015-11-17 22:17:19,891 DEBUG : BROWSER_OUTPUT: 22:17:22 INFO - 2015-11-17 22:17:22,373 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56924/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56924/tests/kraken/driver.html?testName=audio-beat-detection) 22:17:22 INFO - 2015-11-17 22:17:22,974 DEBUG : BROWSER_OUTPUT: RSS: Main: 141803520 22:17:22 INFO - 2015-11-17 22:17:22,974 DEBUG : BROWSER_OUTPUT: 22:17:25 INFO - 2015-11-17 22:17:25,639 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56924/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56924/tests/kraken/driver.html?testName=audio-dft) 22:17:26 INFO - 2015-11-17 22:17:26,240 DEBUG : BROWSER_OUTPUT: RSS: Main: 142553088 22:17:26 INFO - 2015-11-17 22:17:26,241 DEBUG : BROWSER_OUTPUT: 22:17:29 INFO - 2015-11-17 22:17:29,066 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56924/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56924/tests/kraken/driver.html?testName=audio-fft) 22:17:29 INFO - 2015-11-17 22:17:29,653 DEBUG : BROWSER_OUTPUT: RSS: Main: 137265152 22:17:29 INFO - 2015-11-17 22:17:29,653 DEBUG : BROWSER_OUTPUT: 22:17:31 INFO - 2015-11-17 22:17:31,687 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56924/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56924/tests/kraken/driver.html?testName=audio-oscillator) 22:17:32 INFO - 2015-11-17 22:17:32,272 DEBUG : BROWSER_OUTPUT: RSS: Main: 137011200 22:17:32 INFO - 2015-11-17 22:17:32,272 DEBUG : BROWSER_OUTPUT: 22:17:34 INFO - 2015-11-17 22:17:34,446 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56924/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56924/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:17:35 INFO - 2015-11-17 22:17:35,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 137920512 22:17:35 INFO - 2015-11-17 22:17:35,020 DEBUG : BROWSER_OUTPUT: 22:17:38 INFO - 2015-11-17 22:17:38,011 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56924/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56924/tests/kraken/driver.html?testName=imaging-darkroom) 22:17:38 INFO - 2015-11-17 22:17:38,592 DEBUG : BROWSER_OUTPUT: RSS: Main: 138403840 22:17:38 INFO - 2015-11-17 22:17:38,592 DEBUG : BROWSER_OUTPUT: 22:17:42 INFO - 2015-11-17 22:17:42,000 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56924/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56924/tests/kraken/driver.html?testName=imaging-desaturate) 22:17:42 INFO - 2015-11-17 22:17:42,601 DEBUG : BROWSER_OUTPUT: RSS: Main: 139902976 22:17:42 INFO - 2015-11-17 22:17:42,601 DEBUG : BROWSER_OUTPUT: 22:17:45 INFO - 2015-11-17 22:17:45,446 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56924/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56924/tests/kraken/driver.html?testName=json-parse-financial) 22:17:46 INFO - 2015-11-17 22:17:46,040 DEBUG : BROWSER_OUTPUT: RSS: Main: 138584064 22:17:46 INFO - 2015-11-17 22:17:46,040 DEBUG : BROWSER_OUTPUT: 22:17:47 INFO - 2015-11-17 22:17:47,628 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56924/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56924/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:17:48 INFO - 2015-11-17 22:17:48,210 DEBUG : BROWSER_OUTPUT: RSS: Main: 138407936 22:17:48 INFO - 2015-11-17 22:17:48,210 DEBUG : BROWSER_OUTPUT: 22:17:50 INFO - 2015-11-17 22:17:50,047 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56924/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56924/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:17:50 INFO - 2015-11-17 22:17:50,660 DEBUG : BROWSER_OUTPUT: RSS: Main: 138776576 22:17:50 INFO - 2015-11-17 22:17:50,660 DEBUG : BROWSER_OUTPUT: 22:17:52 INFO - 2015-11-17 22:17:52,738 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56924/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56924/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:17:53 INFO - 2015-11-17 22:17:53,319 DEBUG : BROWSER_OUTPUT: RSS: Main: 139558912 22:17:53 INFO - 2015-11-17 22:17:53,319 DEBUG : BROWSER_OUTPUT: 22:17:55 INFO - 2015-11-17 22:17:55,813 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56924/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56924/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:17:56 INFO - 2015-11-17 22:17:56,398 DEBUG : BROWSER_OUTPUT: RSS: Main: 138235904 22:17:56 INFO - 2015-11-17 22:17:56,399 DEBUG : BROWSER_OUTPUT: 22:17:58 INFO - 2015-11-17 22:17:58,965 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56924/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56924/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:17:59 INFO - 2015-11-17 22:17:59,546 DEBUG : BROWSER_OUTPUT: RSS: Main: 139010048 22:17:59 INFO - 2015-11-17 22:17:59,547 DEBUG : BROWSER_OUTPUT: 22:18:01 INFO - 2015-11-17 22:18:01,241 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56924/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56924/tests/kraken/driver.html?testName=ai-astar) 22:18:01 INFO - 2015-11-17 22:18:01,499 DEBUG : BROWSER_OUTPUT: RSS: Main: 139857920 22:18:01 INFO - 2015-11-17 22:18:01,499 DEBUG : BROWSER_OUTPUT: 22:18:01 INFO - 2015-11-17 22:18:01,499 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:18:01 INFO - 2015-11-17 22:18:01,499 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:18:01 INFO - 2015-11-17 22:18:01,500 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:18:01 INFO - 2015-11-17 22:18:01,500 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:18:01 INFO - 2015-11-17 22:18:01,500 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;107;111;111;111;124;111;110;109;108 22:18:01 INFO - 2015-11-17 22:18:01,500 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;134;152;161;126;151;153;131;172;132 22:18:01 INFO - 2015-11-17 22:18:01,501 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;162;161;161;162;162;164;169;161 22:18:01 INFO - 2015-11-17 22:18:01,501 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;74;151;72;72;73;73;149;74 22:18:01 INFO - 2015-11-17 22:18:01,501 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;91;129;90;89;89;132;90;90;140 22:18:01 INFO - 2015-11-17 22:18:01,501 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;110;110;109;109;111;111;109 22:18:01 INFO - 2015-11-17 22:18:01,501 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;146;146;148;147;146;147;156;150 22:18:01 INFO - 2015-11-17 22:18:01,502 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;96;96;96;97;97;96;96;96 22:18:01 INFO - 2015-11-17 22:18:01,502 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;63;63;61;63;63;64;68;63;62 22:18:01 INFO - 2015-11-17 22:18:01,502 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;71;70;69;69;69;69;70;69;70;70 22:18:01 INFO - 2015-11-17 22:18:01,502 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;92;86;85;85;92;85;85;87;85 22:18:01 INFO - 2015-11-17 22:18:01,502 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;115;116;124;119;121;125;132;132;127 22:18:01 INFO - 2015-11-17 22:18:01,503 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;149;155;143;149;155;161;148;151;147 22:18:01 INFO - 2015-11-17 22:18:01,503 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;68;66;67;67;67;73;68;67;65 22:18:01 INFO - 2015-11-17 22:18:01,503 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:18:01 INFO - 2015-11-17 22:18:01,503 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:18:01 INFO - 2015-11-17 22:18:01,503 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,723 22:18:01 INFO - 2015-11-17 22:18:01,504 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:18:01 INFO - 2015-11-17 22:18:01,504 DEBUG : BROWSER_OUTPUT: __startTimestamp1447827481494__endTimestamp 22:18:01 INFO - 2015-11-17 22:18:01,504 DEBUG : BROWSER_OUTPUT: 22:18:01 INFO - 2015-11-17 22:18:01,504 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:18:01 INFO - 2015-11-17 22:18:01,504 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:18:01 INFO - 2015-11-17 22:18:01,504 DEBUG : BROWSER_OUTPUT: 22:18:01 INFO - 2015-11-17 22:18:01,504 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:4.71 (4.2%) stddev-sans-first:4.97 22:18:01 INFO - 2015-11-17 22:18:01,505 DEBUG : BROWSER_OUTPUT: Values: 110.0 107.0 111.0 111.0 111.0 124.0 111.0 110.0 109.0 108.0 22:18:01 INFO - 2015-11-17 22:18:01,505 DEBUG : BROWSER_OUTPUT: 22:18:01 INFO - 2015-11-17 22:18:01,505 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.20 Median:151.50 stddev:14.88 (9.8%) stddev-sans-first:15.71 22:18:01 INFO - 2015-11-17 22:18:01,505 DEBUG : BROWSER_OUTPUT: Values: 150.0 134.0 152.0 161.0 126.0 151.0 153.0 131.0 172.0 132.0 22:18:01 INFO - 2015-11-17 22:18:01,505 DEBUG : BROWSER_OUTPUT: 22:18:01 INFO - 2015-11-17 22:18:01,505 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.60 Median:162.00 stddev:2.41 (1.5%) stddev-sans-first:2.55 22:18:01 INFO - 2015-11-17 22:18:01,505 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 162.0 161.0 161.0 162.0 162.0 164.0 169.0 161.0 22:18:01 INFO - 2015-11-17 22:18:01,505 DEBUG : BROWSER_OUTPUT: 22:18:01 INFO - 2015-11-17 22:18:01,505 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.20 Median:72.50 stddev:32.58 (44.9%) stddev-sans-first:34.03 22:18:01 INFO - 2015-11-17 22:18:01,505 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 74.0 151.0 72.0 72.0 73.0 73.0 149.0 74.0 22:18:01 INFO - 2015-11-17 22:18:01,505 DEBUG : BROWSER_OUTPUT: 22:18:01 INFO - 2015-11-17 22:18:01,505 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.90 Median:89.50 stddev:21.41 (23.9%) stddev-sans-first:22.11 22:18:01 INFO - 2015-11-17 22:18:01,506 DEBUG : BROWSER_OUTPUT: Values: 89.0 91.0 129.0 90.0 89.0 89.0 132.0 90.0 90.0 140.0 22:18:01 INFO - 2015-11-17 22:18:01,506 DEBUG : BROWSER_OUTPUT: 22:18:01 INFO - 2015-11-17 22:18:01,507 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 22:18:01 INFO - 2015-11-17 22:18:01,507 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 110.0 110.0 109.0 109.0 111.0 111.0 109.0 22:18:01 INFO - 2015-11-17 22:18:01,507 DEBUG : BROWSER_OUTPUT: 22:18:01 INFO - 2015-11-17 22:18:01,507 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.00 Median:147.50 stddev:3.09 (2.1%) stddev-sans-first:3.28 22:18:01 INFO - 2015-11-17 22:18:01,507 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 146.0 146.0 148.0 147.0 146.0 147.0 156.0 150.0 22:18:01 INFO - 2015-11-17 22:18:01,507 DEBUG : BROWSER_OUTPUT: 22:18:01 INFO - 2015-11-17 22:18:01,507 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 22:18:01 INFO - 2015-11-17 22:18:01,507 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 96.0 96.0 96.0 97.0 97.0 96.0 96.0 96.0 22:18:01 INFO - 2015-11-17 22:18:01,507 DEBUG : BROWSER_OUTPUT: 22:18:01 INFO - 2015-11-17 22:18:01,507 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:63.30 Median:63.00 stddev:1.83 (2.9%) stddev-sans-first:1.94 22:18:01 INFO - 2015-11-17 22:18:01,508 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 63.0 61.0 63.0 63.0 64.0 68.0 63.0 62.0 22:18:01 INFO - 2015-11-17 22:18:01,508 DEBUG : BROWSER_OUTPUT: 22:18:01 INFO - 2015-11-17 22:18:01,508 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.00 stddev:0.70 (1.0%) stddev-sans-first:0.53 22:18:01 INFO - 2015-11-17 22:18:01,508 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 69.0 69.0 69.0 69.0 70.0 69.0 70.0 70.0 22:18:01 INFO - 2015-11-17 22:18:01,508 DEBUG : BROWSER_OUTPUT: 22:18:01 INFO - 2015-11-17 22:18:01,508 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:85.50 stddev:2.87 (3.4%) stddev-sans-first:2.98 22:18:01 INFO - 2015-11-17 22:18:01,508 DEBUG : BROWSER_OUTPUT: Values: 85.0 92.0 86.0 85.0 85.0 92.0 85.0 85.0 87.0 85.0 22:18:01 INFO - 2015-11-17 22:18:01,508 DEBUG : BROWSER_OUTPUT: 22:18:01 INFO - 2015-11-17 22:18:01,508 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.70 Median:124.50 stddev:6.36 (5.1%) stddev-sans-first:6.27 22:18:01 INFO - 2015-11-17 22:18:01,508 DEBUG : BROWSER_OUTPUT: Values: 116.0 115.0 116.0 124.0 119.0 121.0 125.0 132.0 132.0 127.0 22:18:01 INFO - 2015-11-17 22:18:01,508 DEBUG : BROWSER_OUTPUT: 22:18:01 INFO - 2015-11-17 22:18:01,508 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.40 Median:150.00 stddev:6.90 (4.6%) stddev-sans-first:5.35 22:18:01 INFO - 2015-11-17 22:18:01,508 DEBUG : BROWSER_OUTPUT: Values: 136.0 149.0 155.0 143.0 149.0 155.0 161.0 148.0 151.0 147.0 22:18:01 INFO - 2015-11-17 22:18:01,508 DEBUG : BROWSER_OUTPUT: 22:18:01 INFO - 2015-11-17 22:18:01,508 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.00 stddev:2.17 (3.2%) stddev-sans-first:2.24 22:18:01 INFO - 2015-11-17 22:18:01,508 DEBUG : BROWSER_OUTPUT: Values: 66.0 68.0 66.0 67.0 67.0 67.0 73.0 68.0 67.0 65.0 22:18:01 INFO - 2015-11-17 22:18:01,509 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:18:01 INFO - 2015-11-17 22:18:01,509 DEBUG : BROWSER_OUTPUT: 22:18:02 INFO - 2015-11-17 22:18:02,408 INFO : Browser exited with error code: 0 22:18:02 INFO - 2015-11-17 22:18:02,456 INFO : Completed test kraken (00:01:00) 22:18:02 INFO - 2015-11-17 22:18:02,457 INFO : Starting test v8_7 22:18:02 INFO - 2015-11-17 22:18:02,457 DEBUG : operating with platform_type : linux_ 22:18:02 INFO - 2015-11-17 22:18:02,457 INFO : Initialising browser for v8_7 test... 22:18:02 INFO - 2015-11-17 22:18:02,463 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaQS94y/profile http://localhost:56924/getInfo.html 22:18:07 INFO - 2015-11-17 22:18:07,364 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:18:07 INFO - 2015-11-17 22:18:07,365 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:18:07 INFO - 2015-11-17 22:18:07,365 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:18:07 INFO - 2015-11-17 22:18:07,365 DEBUG : BROWSER_OUTPUT: __metrics 22:18:08 INFO - 2015-11-17 22:18:08,716 INFO : Browser initialized. 22:18:08 INFO - 2015-11-17 22:18:08,717 INFO : Running cycle 1/1 for v8_7 test... 22:18:08 INFO - 2015-11-17 22:18:08,717 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaQS94y/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:18:20 INFO - 2015-11-17 22:18:20,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 141479936 22:18:20 INFO - 2015-11-17 22:18:20,493 DEBUG : BROWSER_OUTPUT: 22:18:41 INFO - 2015-11-17 22:18:41,849 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56924/tests/v8_7/run.html (next: http://localhost:56924/tests/v8_7/run.html) 22:18:42 INFO - 2015-11-17 22:18:42,099 DEBUG : BROWSER_OUTPUT: RSS: Main: 137437184 22:18:42 INFO - 2015-11-17 22:18:42,099 DEBUG : BROWSER_OUTPUT: 22:18:42 INFO - 2015-11-17 22:18:42,100 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:18:42 INFO - 2015-11-17 22:18:42,100 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:18:42 INFO - 2015-11-17 22:18:42,100 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:18:42 INFO - 2015-11-17 22:18:42,100 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:18:42 INFO - 2015-11-17 22:18:42,100 DEBUG : BROWSER_OUTPUT: |0;Richards;166.66666666666666 22:18:42 INFO - 2015-11-17 22:18:42,100 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.60758766047135 22:18:42 INFO - 2015-11-17 22:18:42,101 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.08744710860367 22:18:42 INFO - 2015-11-17 22:18:42,101 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 22:18:42 INFO - 2015-11-17 22:18:42,101 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1059.322033898305 22:18:42 INFO - 2015-11-17 22:18:42,101 DEBUG : BROWSER_OUTPUT: |5;Earley;713.2667617689016 22:18:42 INFO - 2015-11-17 22:18:42,101 DEBUG : BROWSER_OUTPUT: |6;Boyer;12207.317073170732 22:18:42 INFO - 2015-11-17 22:18:42,101 DEBUG : BROWSER_OUTPUT: |7;RegExp;26447.36842105263 22:18:42 INFO - 2015-11-17 22:18:42,101 DEBUG : BROWSER_OUTPUT: |8;Splay;583.1395348837209 22:18:42 INFO - 2015-11-17 22:18:42,101 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 22:18:42 INFO - 2015-11-17 22:18:42,101 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:18:42 INFO - 2015-11-17 22:18:42,101 DEBUG : BROWSER_OUTPUT: __startTimestamp1447827522098__endTimestamp 22:18:42 INFO - 2015-11-17 22:18:42,102 DEBUG : BROWSER_OUTPUT: 22:18:42 INFO - 2015-11-17 22:18:42,102 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:18:42 INFO - 2015-11-17 22:18:42,102 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:18:42 INFO - 2015-11-17 22:18:42,102 DEBUG : BROWSER_OUTPUT: 22:18:42 INFO - 2015-11-17 22:18:42,102 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.67 Median:166.67 stddev:0.00 (0.0%) 22:18:42 INFO - 2015-11-17 22:18:42,102 DEBUG : BROWSER_OUTPUT: Values: 166.7 22:18:42 INFO - 2015-11-17 22:18:42,102 DEBUG : BROWSER_OUTPUT: 22:18:42 INFO - 2015-11-17 22:18:42,102 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.61 Median:191.61 stddev:0.00 (0.0%) 22:18:42 INFO - 2015-11-17 22:18:42,102 DEBUG : BROWSER_OUTPUT: Values: 191.6 22:18:42 INFO - 2015-11-17 22:18:42,102 DEBUG : BROWSER_OUTPUT: 22:18:42 INFO - 2015-11-17 22:18:42,102 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.09 Median:282.09 stddev:0.00 (0.0%) 22:18:42 INFO - 2015-11-17 22:18:42,102 DEBUG : BROWSER_OUTPUT: Values: 282.1 22:18:42 INFO - 2015-11-17 22:18:42,103 DEBUG : BROWSER_OUTPUT: 22:18:42 INFO - 2015-11-17 22:18:42,103 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 22:18:42 INFO - 2015-11-17 22:18:42,103 DEBUG : BROWSER_OUTPUT: Values: 5040.2 22:18:42 INFO - 2015-11-17 22:18:42,103 DEBUG : BROWSER_OUTPUT: 22:18:42 INFO - 2015-11-17 22:18:42,104 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1059.32 Median:1059.32 stddev:0.00 (0.0%) 22:18:42 INFO - 2015-11-17 22:18:42,104 DEBUG : BROWSER_OUTPUT: Values: 1059.3 22:18:42 INFO - 2015-11-17 22:18:42,104 DEBUG : BROWSER_OUTPUT: 22:18:42 INFO - 2015-11-17 22:18:42,104 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:713.27 Median:713.27 stddev:0.00 (0.0%) 22:18:42 INFO - 2015-11-17 22:18:42,105 DEBUG : BROWSER_OUTPUT: Values: 713.3 22:18:42 INFO - 2015-11-17 22:18:42,105 DEBUG : BROWSER_OUTPUT: 22:18:42 INFO - 2015-11-17 22:18:42,105 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 22:18:42 INFO - 2015-11-17 22:18:42,105 DEBUG : BROWSER_OUTPUT: Values: 12207.3 22:18:42 INFO - 2015-11-17 22:18:42,105 DEBUG : BROWSER_OUTPUT: 22:18:42 INFO - 2015-11-17 22:18:42,105 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26447.37 Median:26447.37 stddev:0.00 (0.0%) 22:18:42 INFO - 2015-11-17 22:18:42,105 DEBUG : BROWSER_OUTPUT: Values: 26447.4 22:18:42 INFO - 2015-11-17 22:18:42,105 DEBUG : BROWSER_OUTPUT: 22:18:42 INFO - 2015-11-17 22:18:42,106 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:583.14 Median:583.14 stddev:0.00 (0.0%) 22:18:42 INFO - 2015-11-17 22:18:42,106 DEBUG : BROWSER_OUTPUT: Values: 583.1 22:18:42 INFO - 2015-11-17 22:18:42,106 DEBUG : BROWSER_OUTPUT: 22:18:42 INFO - 2015-11-17 22:18:42,106 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 22:18:42 INFO - 2015-11-17 22:18:42,106 DEBUG : BROWSER_OUTPUT: Values: 4854.4 22:18:42 INFO - 2015-11-17 22:18:42,106 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:18:42 INFO - 2015-11-17 22:18:42,106 DEBUG : BROWSER_OUTPUT: 22:18:42 INFO - 2015-11-17 22:18:42,944 INFO : Browser exited with error code: 0 22:18:42 INFO - 2015-11-17 22:18:42,959 INFO : Completed test v8_7 (00:00:40) 22:18:43 INFO - 2015-11-17 22:18:43,153 INFO : Completed test suite (00:20:11) 22:18:43 INFO - 2015-11-17 22:18:43,154 DEBUG : Working with test: dromaeo_css 22:18:43 INFO - 2015-11-17 22:18:43,154 DEBUG : Generating results file: dromaeo_css 22:18:43 INFO - 2015-11-17 22:18:43,155 DEBUG : Working with test: kraken 22:18:43 INFO - 2015-11-17 22:18:43,155 DEBUG : Generating results file: kraken 22:18:43 INFO - 2015-11-17 22:18:43,155 INFO : javascript benchmark 22:18:43 INFO - 2015-11-17 22:18:43,155 DEBUG : Working with test: v8_7 22:18:43 INFO - 2015-11-17 22:18:43,156 DEBUG : Generating results file: v8_7 22:18:43 INFO - 2015-11-17 22:18:43,156 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:18:43 INFO - 2015-11-17 22:18:43,209 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 22:18:43 INFO - 2015-11-17 22:18:43,210 DEBUG : process_Request line: dromaeo_css 6742.50 graph.html#tests=[[72,64,43]] 22:18:43 INFO - 2015-11-17 22:18:43,210 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:18:43 INFO - 2015-11-17 22:18:43,237 DEBUG : process_Request line: kraken 1524.30 graph.html#tests=[[232,64,43]] 22:18:43 INFO - 2015-11-17 22:18:43,237 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:18:43 INFO - 2015-11-17 22:18:43,260 DEBUG : process_Request line: v8_7 21372.60 graph.html#tests=[[230,64,43]] 22:18:43 INFO - 2015-11-17 22:18:43,261 INFO : javascript benchmark 22:18:43 INFO - 2015-11-17 22:18:43,265 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [356.16834690996507, 359.80570491934355, 362.31341607653496, 362.54319557357724, 364.3623658597455, 12476.563320283769, 12776.808347874767, 16663.166841657912, 17392.217350219238, 18113.728294075583, 11817.231879927798, 11893.583724569642, 11956.701082472942, 12024.158308918379, 12189.781021897807, 4454.220511410506, 4527.4340707411575, 4536.9092618147615, 4567.246404343296, 4569.0, 4799.904001919959, 4898.387701537308, 4902.730349830758, 4906.877328066809, 4914.066327397783, 4608.654350923677, 4686.929696054562, 4727.196376615966, 4856.198727210024, 4867.780949857265, 4647.326137710047, 4714.976425117887, 4754.833580824689, 4756.120117778205, 4761.880952976186, 4321.481422229321, 4345.174416860787, 4375.387445757597, 4395.230834603932, 4400.295952647593, 13623.523176688868, 13838.861611383958, 13895.722085558333, 14401.063930844462, 14487.710245795026, 1848.122141982561, 1957.725918371415, 1972.753405824272, 1976.495993521657, 1996.2414282572674, 10195.694129176136, 10324.174066074696, 10411.739706507322, 10488.947555262252, 10560.841587376195, 1738.391562952969, 1743.4333841501436, 1762.9911850440665, 1769.3630293094475, 1783.7301883878179, 60364.69817650928, 61404.999999999556, 61985.38014619886, 62468.0, 63275.36724632787, 7178.856422871513, 7255.782326530212, 7277.2722727726805, 7288.125424948934, 7313.670884810196, 8527.616257268437, 8543.658253669908, 8543.786405339917, 8549.316054715608, 8560.571971401405, 5544.528715059265, 5580.386157522669, 5585.245991791137, 5602.243697100921, 5614.9157762633595, 5731.570132240098, 5736.340320863071, 5742.109972954116, 5750.079987202028, 5770.740316685759, 3324.9002529923655, 3327.8169700666213, 3343.5653365062385, 3348.079278198515, 3377.2401209727614, 1157.2535714464123, 1167.6030149748956, 1186.9169158158845, 1189.2983139947473, 1194.319238034312, 402.86705387222145, 420.690792267683, 423.860126158367, 450.4864454521848, 452.6311056488951, 10633.149348052137, 10874.0, 10883.401412922207, 10911.781764364669, 11002.559897604006, 420.18274456182434, 423.1536926147705, 431.6676159357277, 434.6631360695486, 443.3327841598374, 5896.528277737771, 6528.445082167974, 6690.397864192246, 6857.2114206866845, 6875.209350924708, 521278.0, 521657.0, 529414.0, 531072.0, 532796.0, 72046.0, 76016.0, 76830.0, 76915.61542192253, 79369.60315198387, 566.3600131850982, 574.3395095640047, 578.0721941284262, 578.6846168837993, 578.774278031568, 10894.61868834587, 11450.0, 11572.36352000648, 11748.530058797553, 11917.106217033584, 32953.0, 33549.83225083859, 33636.831815840764, 33745.83127084349, 34409.139771505914, 46149.76925115353, 46899.765501172275, 47131.764341178074, 47429.288560670924, 47447.0, 6413.0701048348665, 6589.934100659124, 6599.340065993362, 6743.325667433413, 6860.759873404407, 12068.275903445821, 12282.570110046105, 12385.504579816707, 12464.626061218178, 12508.437120329425, 10578.100861426557, 10891.455427228766, 10966.451677416257, 10992.340459572451, 11003.064739496913, 10407.68776936693, 10718.24972251935, 10857.511411986321, 10878.0, 10881.129509639051, 10841.07850832688, 10903.618373356894, 10971.561137554727, 11083.168762342695, 11130.0, 6413.454856337264, 6422.839429014312, 6464.997925321582, 6465.579737317059, 6485.578437401554, 11116.49975751077, 11237.831432528683, 11248.043916267208, 11424.771504569695, 11465.598704045318], "dojo.html": [3222.8710851565934, 3269.3134441767243, 3301.356235534072, 3303.0, 3316.436205845006, 5251.291075704778, 5274.73626318684, 5310.787568497255, 5324.62727609067, 5382.703951282683, 5317.46825317468, 5335.466453354663, 5352.464753524646, 5403.162509810976, 5420.403755586883, 4879.512048795127, 4895.216765317541, 4967.801287948478, 4980.27785971034, 5017.247412888078, 4988.850334489971, 5014.147594908856, 5014.423341315759, 5035.697858128506, 5054.974725126369, 4783.1868582341085, 4851.757412129379, 4946.258061290817, 4975.427825800007, 4989.401271847401, 4849.563539281482, 4854.684445511066, 4857.0, 4871.050145221683, 4883.365162528884, 4782.545658162504, 4852.878678033042, 4862.708237505725, 4863.27050942358, 4877.756112194412, 5133.383993920716, 5204.76578553966, 5214.035403450373, 5221.112410890158, 5233.633645644806, 5785.218995435646, 5790.392008839053, 5796.536277097822, 5799.159121927339, 5804.65172089676, 5726.484616384504, 5817.447342502455, 5851.0, 5852.209951656514, 5879.735411906475, 5353.866153346197, 5516.613837031409, 5540.639858409231, 5541.612087153901, 5546.889062218774, 5778.104393818965, 5852.063669812809, 5945.910811337833, 5951.166836642873, 5963.224780778471, 5719.5138413235345, 5757.366689664133, 5760.308762948389, 5773.538116950634, 5781.219535362757, 5650.5479561634975, 5788.710564471844, 5789.768409263583, 5801.0, 5814.447627475383, 5751.22358481608, 5759.510441612426, 5763.740631671585, 5765.654060756368, 5810.477057064884, 5703.74333155009, 5715.599908006399, 5752.453516915886, 5765.798197063166, 5774.39368866263, 4347.7173983690955, 4395.406620106309, 4430.689851710349, 4468.352088947085, 4469.575390337913, 4023.0746928206677, 4047.2310261050893, 4051.1897620476025, 4051.2910240707756, 4095.651869591118, 5551.639143455663, 5577.414371491016, 5580.944190558123, 5588.944110558842, 5626.212330273765, 5635.408282130399, 5700.458456446631, 5720.628159169641, 5762.971185144132, 5826.563007774434, 5605.383407825136, 5622.493975542221, 5623.578231632644, 5626.521745651666, 5635.098384258581, 4978.975105124451, 5087.720175390389, 5093.159628661229, 5111.616628752784, 5154.0, 5937.2578427696535, 5988.610740301867, 6014.097885317325, 6100.908486372708, 6139.877202455926, 5801.0, 5802.0426629605645, 5809.883802324014, 5825.213596164633, 5860.472557469848, 5845.298564172326, 5907.793227237026, 6029.487493563096, 6034.39656034393, 6053.969730151321, 5645.633033852787, 5693.117566777156, 5698.373178950395, 5699.0, 5712.857178570569, 5868.501177399969, 5921.259842519685, 5932.16949627044, 5959.046552551571, 5962.4633782959745, 5486.478784515464, 5620.241267428844, 5768.394318596487, 5786.739596718242, 5814.796482123105, 5669.688167150846, 5671.234383358359, 5679.630823996427, 5685.630434021776, 5774.39368866263, 5577.6653400796085, 5578.135389014709, 5580.972095139498, 5581.776728930798, 5589.888202236014, 5554.416786237387, 5665.065264231355, 5681.261436013292, 5685.971570142288, 5782.277215348082, 5595.860103497445, 5615.606907516598, 5617.859553511032, 5623.662580245198, 5628.802991895264], "mootools.html": [1488.397199134351, 1714.982850171498, 1747.2224859937332, 1755.9385421510249, 1786.231920274282, 7424.294692004264, 7716.884246736304, 7737.148913619498, 7898.407619428537, 7934.9603251983735, 8006.639701213445, 8046.798830029237, 8080.919190808105, 8102.473339232945, 8112.351011919047, 2266.977330226697, 2295.4031951692596, 2296.0700916128994, 2296.2881506732883, 2302.297799171252, 2298.425393651587, 2328.0338659456306, 2345.929622111331, 2346.4133966508375, 2349.119080344871, 2191.2221161487682, 2235.4634887626935, 2237.272886311947, 2264.388615073929, 2283.954320913581, 2220.844540882139, 2239.4177513846353, 2298.8505747126383, 2305.1010106058734, 2315.178111770331, 2303.009705826494, 2324.9070037198494, 2327.197116994634, 2331.160782118436, 2336.6027775278244, 7869.252421019994, 7943.046834379911, 7954.721584744506, 7965.920340796576, 7966.760997170094, 4696.201645720202, 4768.427788665383, 4781.569658730697, 4829.589484893788, 4839.637027222937, 3046.7257946784675, 3048.7103725146076, 3092.1496588438135, 3093.180307218589, 3123.859426325821, 1025.0710752330715, 1036.0623635609786, 1055.3404122423485, 1081.3674000709593, 1924.5573518090916, 10855.40295283759, 10894.237403381687, 10895.0, 10915.83626245599, 10948.835767463494, 4145.937810932838, 4228.936565951513, 4337.891552711208, 4443.155800397914, 4515.571020753023, 8646.394752367274, 8810.207081362709, 8818.559072046372, 8827.0, 8827.205551500396, 4806.855794326176, 4816.8314109006715, 4817.975910120427, 4827.058723548945, 4835.95164048355, 4365.257906155961, 4386.846460373936, 4388.978055109704, 4389.144116897174, 4418.359337896051, 3487.3548393547276, 3492.388831954398, 3530.6822385985383, 3541.4156664150128, 3546.0, 1062.8990245926625, 1064.8722153341648, 1069.096613361708, 1070.5878236878857, 1076.4832880217539, 1006.2654262388497, 1013.5287091502487, 1071.528527447936, 1159.5477763672175, 1321.4648067532664, 7380.114386273682, 7470.103587569526, 7487.47587668858, 7530.698772049166, 7539.73610923626, 1141.9094764499882, 1149.9770004599861, 1159.7274640459486, 1170.2861254634665, 1174.7356844710043, 5864.648121112747, 5875.676837773964, 5891.381404952418, 5899.646021238739, 5922.318933322636, 9178.632854685871, 9573.569189386495, 9584.233261339075, 9713.660021899199, 9766.218702503782, 9436.575354109082, 9456.669016584525, 9502.0, 9518.0, 9608.9039109608, 7201.207867134611, 7396.0754905636795, 7423.62881855905, 7438.851222975511, 7498.4376171787335, 7032.26161253061, 7081.645917704197, 7091.9290807091265, 7095.077639906779, 7137.571745695275, 8132.959335203286, 8251.876221856557, 8349.95825020871, 8351.20663536963, 8444.915550844413, 8279.420440569102, 8553.187447192755, 8562.229399354088, 8632.78418039554, 8729.476231426135, 6910.2398736137975, 6989.8951515726285, 7022.0, 7025.68384422692, 7033.191183014019, 7679.462437629312, 7733.149353570991, 7760.456768026184, 7767.145613982344, 7801.0, 7059.0, 7218.927810721825, 7268.600226987566, 7407.59258240802, 7416.480846340704, 6579.901301480578, 6623.966880165568, 6963.477739169683, 7049.823754406181, 7300.12398512182, 7192.0, 7243.5653860768525, 7271.2365201653065, 7274.527155734861, 7292.96353518229, 6468.191476065492, 6694.799156025327, 6695.330466953461, 6711.731530738911, 6712.026756120237, 6618.305077966937, 6652.667366631746, 6694.230163531061, 6695.0, 6698.732050718112], "ext.html": [568.8122919436586, 604.8276241271238, 611.6880391000591, 628.6605233174087, 630.0486265738733, 38358.0, 39497.21005579894, 39508.40737388938, 39509.20981580374, 39536.0, 42132.0, 42568.78715606425, 42858.57141428593, 42863.78568107155, 42932.35601465973, 8632.870506942401, 8694.521801300925, 8785.121487851227, 8787.736367908972, 8795.120487951186, 8407.95796021022, 8459.746207613782, 8557.315414766836, 8565.571721413935, 8604.311655067611, 8383.077861435268, 8455.53494557799, 8455.788605284855, 8461.746147615582, 8470.28002619775, 8608.182222688834, 8694.826103477895, 8701.260392866614, 8717.171868672465, 8735.432196907212, 8535.061143274235, 8564.229219370287, 8666.046734859161, 8668.133186681282, 8684.305255579538, 39456.21087578261, 39528.80235598832, 39812.20375592501, 39827.601723982676, 39861.00347491307, 2924.3274046969104, 3213.962805149135, 3281.950770738441, 3413.3173365326784, 3898.298306304864, 29314.657825249735, 29394.559081613792, 29690.851545742134, 29769.553456698166, 30159.69840301613, 3275.96724032759, 3366.1248075500303, 3389.983050084734, 3485.076454739496, 3502.544669193014, 266888.0, 268230.65884670644, 268423.0, 268786.0, 268804.999999998, 42891.57108428938, 43285.78357108194, 43643.34534981978, 57364.71317643385, 57585.0, 42330.78834605807, 42333.36499952503, 42402.36396454056, 42475.05349251107, 42775.7861210692, 13324.533641322507, 13414.0, 13456.25990570528, 13458.259795711134, 13467.595972120853, 10707.089897358812, 10755.56977720898, 10795.136389088853, 10818.188635852342, 10824.18818588609, 14499.710005799825, 14604.780928286084, 14623.634409139857, 14652.12087274767, 14733.55799326022, 5881.735321910524, 6013.729382177812, 6014.218151640259, 6082.422169893853, 6094.116353128771, 851.880736696863, 881.2113158722907, 946.5172761891484, 969.6412327438893, 1007.3452256033637, 28648.85675571609, 29256.7074329254, 29336.413271734447, 32051.51922721161, 32818.83590582032, 949.2216382566229, 1045.5086109528509, 1068.9203904056958, 1106.651404807483, 1157.9652610421701, 14849.628759281104, 15169.469068582546, 15217.239138043275, 15345.0, 15467.458638947808, 376118.0, 377869.0, 381333.0, 382217.0, 382925.0, 52810.0, 53438.73280633572, 53497.46502534925, 53657.73171134119, 53913.191302129715, 1223.5472875036294, 1319.9340032998505, 1320.4982106799162, 1338.4980632262902, 1367.2206842099908, 27696.584551231346, 28416.857915711116, 28733.28166795847, 28987.56518652264, 29074.854625726737, 45958.0, 46241.76879115583, 46456.0, 46628.0, 46693.76653116713, 297670.0, 298045.0, 298562.0, 299453.0, 300298.0, 32187.67812321847, 46129.077418452114, 46184.0, 46323.53676463327, 46834.29748553706, 42991.785041074596, 43030.35454468248, 43087.784561078246, 43487.0, 44129.77935110304, 36188.0, 36575.08562285964, 40342.79828600838, 41625.37561936634, 41720.79139604283, 37086.11897174563, 37301.253974920895, 37482.812585936896, 37503.43744843884, 37794.433083503216, 35516.0, 35960.28079438449, 36471.27057458889, 36553.81723091367, 36681.63318366782, 32276.677233228307, 34301.65698342985, 34496.655033449344, 34603.30793384169, 42682.78658606687, 29995.700043000164, 30484.237894052825, 31002.0, 32470.0, 34262.31475370429], "prototype.html": [334.8141781311371, 343.73360645499736, 345.4938515075414, 347.6245654692931, 351.21678656595793, 6228.968855155729, 6230.439260466557, 6248.687565621718, 6249.093881387207, 6435.774747883825, 6193.411625895544, 6202.4417802397775, 6221.688915554227, 6259.0, 6304.054391841215, 4743.075100355432, 4755.619550435957, 4776.211925032366, 4780.426348838136, 4785.71285722856, 4739.6208303335825, 4750.026244619845, 4774.092922344761, 4780.976095119519, 4786.976065119669, 4651.093036857814, 4669.976650116745, 4724.976375118137, 4742.288656701505, 4778.163821331271, 4744.596709279698, 4754.0, 4785.042991401699, 4785.904281914377, 4789.257665061904, 4181.97909010453, 4204.747715137101, 4209.810558524874, 4217.156568686275, 4227.0, 5916.290045194562, 5951.791687290967, 5955.880882382371, 5961.314448838396, 5967.254093238345, 5454.672719636835, 5567.805126820583, 5576.275084239023, 5577.8047768327915, 5590.944090559083, 6564.638944858031, 6593.505487088488, 6622.403983641495, 6624.668766561653, 6632.966835165842, 4647.34937108805, 4658.231391820379, 4661.417322834645, 4664.603508701764, 4665.766711664403, 6765.560238584476, 6805.48958828085, 6873.037774711544, 6882.070920425728, 6883.724651013953, 4797.592204662573, 4799.688020278671, 4806.7836947337455, 4806.855794326176, 4808.158572249842, 4874.8781280467565, 4877.146499362598, 4880.365552478155, 4883.58489528387, 4891.144049791273, 5574.58190635704, 5583.748731307101, 5591.720413979285, 5601.775928962796, 5604.803831865946, 6620.867582648417, 6650.900236496456, 6685.264620891698, 6702.329767023259, 6721.294264102199, 1703.276107654242, 1718.7164117920404, 1722.0872937343229, 1731.480555833245, 1737.695903216932, 1170.4791367841399, 1170.8770579089073, 1179.6402097360217, 1184.4137152109588, 1189.5241903238773, 6460.676966151674, 6474.546781725234, 6477.093206951031, 6479.967600161969, 6482.481401487869, 6864.1762988440705, 6866.313368663194, 6877.724891004404, 6893.7931862044215, 6909.2745261746795, 6316.589421687668, 6414.422701956846, 6420.807375778734, 6462.450691691259, 6558.704858281389, 3771.283456143324, 3777.622237776255, 3778.848846046182, 3780.527434070741, 3801.334766415866, 7247.23903990084, 7298.306660867209, 7313.341799238094, 7317.231690672509, 7317.963410183022, 6977.162740471074, 7141.14306283239, 7181.138263408425, 7189.964050179716, 7207.855842883113, 7227.9638601806655, 7272.745453909193, 7284.745033923788, 7286.890696639554, 7291.0157128788, 6934.375906168469, 6936.930630693629, 6984.895226571504, 6988.965055174692, 6993.895091573529, 6742.056112144402, 6831.180258369028, 6863.553868998499, 6907.930920690729, 6911.067005954333, 7226.385757210696, 7268.9273107270365, 7278.963605182152, 7283.380912622486, 7309.195988441374, 4662.696924699883, 4702.435707715096, 4714.858554243378, 4715.12770137512, 4725.125851717443, 6701.229358623821, 6857.451403887577, 6909.619970901648, 6933.064036355229, 6988.0, 6711.194656641039, 6732.663366831541, 6741.157355330583, 6753.527253092237, 6755.1556055493065, 6680.131582894387, 6743.15710536183, 6751.358620931003, 6752.527323087336, 6770.4922130839395, 6463.870722585616, 6599.868002639824, 6618.801435956929, 6640.335966403321, 6660.400563949268, 6755.729770809113, 6786.8642627148165, 6795.218549866829, 6799.524033317621, 6819.659017049227, 6485.902711459237, 6598.241202261801, 6627.204735431779, 6628.668566571749, 6629.138212032405], "yui.html": [846.991530084699, 855.1106848877168, 860.1785295043235, 875.8905136857893, 882.8719835623834, 13234.669133271662, 14554.19951902645, 14590.78113828292, 14656.706865862676, 14673.486427975024, 13653.590392288223, 13747.793783093262, 13843.515476958308, 13851.099678520914, 13860.4455821767, 799.7800604833689, 814.5072231300067, 815.6981916690803, 822.0751654388813, 828.7140936376941, 813.3208770676492, 814.5316443045243, 819.8196396792725, 822.4160845799489, 823.4894365493402, 829.2205326992638, 840.2143995364323, 842.3135144856922, 844.5397258494105, 845.2012847858776, 825.4345773145415, 827.8385714785619, 830.9626066826977, 835.9582020898931, 837.3970741066422, 610.3957082488305, 611.0437165835453, 611.9321783487842, 611.9755209791603, 613.0008086818502, 13281.667958301023, 13355.465781368734, 13376.799348009788, 13404.0, 13414.798778018338, 9894.802103957953, 10560.155187585051, 10562.419066951315, 10628.043476087112, 10683.83974240387, 9585.712428627152, 9754.561044753003, 9787.314887957775, 9890.15933645641, 10203.540840662188, 3177.809331440121, 3192.409404260196, 3236.2394837213237, 3298.538204651351, 3313.2545177335146, 42199.9450013749, 42650.933726656775, 43261.783691081655, 43264.0, 43547.0, 6813.454923606099, 6843.349881761224, 6898.1377327834025, 7028.367446929801, 7032.789016329519, 10829.458527073615, 10915.945420273007, 10918.399488028075, 10922.890771092347, 10984.395858227714, 6350.206224221973, 6401.943679292957, 6430.614163150226, 6487.513436492282, 6498.057781621638, 4121.876343709693, 4180.749155050707, 4206.68172725734, 4269.359596060615, 4304.5480224576595, 2651.946961060768, 2690.0, 2708.8916443342046, 2709.539378305693, 2713.6743590769233, 420.6214407033633, 468.5829611645638, 477.3150528990909, 482.1682597519321, 484.7091744953, 573.7934343636288, 626.8244891430406, 636.6307541625846, 649.9545031847725, 674.5514233035075, 8579.0, 8759.080296568896, 9027.864582031274, 9495.14543691071, 9505.477198753997, 674.1909708349901, 680.6596701649175, 690.5821977703417, 702.4871843554234, 704.7005022865262, 4039.7576145431367, 4104.91790164195, 4264.488261408589, 4283.528811830696, 4288.978555107205, 58048.4195158043, 58345.41654583485, 58842.0, 58863.0, 59352.10971835426, 53044.73477632587, 53356.0, 53651.46348536543, 53802.73098634482, 54010.0, 45469.317960230626, 45515.0, 46211.53788462139, 47684.284735729685, 49064.7546762271, 8833.160849719266, 8850.557472126238, 9270.44377337362, 9295.0, 9417.717468475958, 32836.01491955245, 33945.0, 34009.149771255914, 34624.82687586546, 34760.478592820626, 41313.79343103265, 43098.0, 44187.55812441834, 44709.10581788411, 44849.55150448584, 8610.268127209258, 8758.299336053227, 8760.080191580048, 8774.736757897273, 8780.780480487783, 12350.258984460961, 12516.87483125157, 12519.874801251872, 13059.412326445523, 13209.405576748877, 10913.945430272797, 11098.500567474644, 11497.425128743362, 11604.0, 11899.226550274205, 11236.97507494477, 11529.654110376701, 11563.768724625292, 11566.595169169039, 11916.285022898654, 10448.065679810921, 10640.52117654692, 11052.723681907695, 11290.096792256763, 11504.0, 10043.89956100459, 10184.439855808001, 10214.54034568461, 10396.376217426978, 10801.567937282422, 9186.173244408035, 9436.811263774824, 9768.902310977084, 9980.151687106678, 10043.548040338057]}, "summary": {"lowerIsBetter": false, "suite": 6742.505548310994, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6893.626548334235, "unit": "ms", "value": 6893.626548334235}, "dojo.html": {"lowerIsBetter": false, "filtered": 5356.442369919984, "unit": "ms", "value": 5356.442369919984}, "mootools.html": {"lowerIsBetter": false, "filtered": 4562.769648441035, "unit": "ms", "value": 4562.769648441035}, "ext.html": {"lowerIsBetter": false, "filtered": 18248.742712710253, "unit": "ms", "value": 18248.742712710253}, "prototype.html": {"lowerIsBetter": false, "filtered": 5059.694559672017, "unit": "ms", "value": 5059.694559672017}, "yui.html": {"lowerIsBetter": false, "filtered": 6039.257756681577, "unit": "ms", "value": 6039.257756681577}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-041.e"}, "testrun": {"date": 1447826311, "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": "20151117203118", "branch": "Fx-Team", "revision": "6fa3b2df62cc80058ea2f63834dcbdd6ec7caa36"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 162.0, 162.0, 161.0, 161.0, 162.0, 162.0, 164.0, 169.0, 161.0], "ai-astar": [110.0, 107.0, 111.0, 111.0, 111.0, 124.0, 111.0, 110.0, 109.0, 108.0], "imaging-gaussian-blur": [110.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 111.0, 111.0, 109.0], "audio-beat-detection": [150.0, 134.0, 152.0, 161.0, 126.0, 151.0, 153.0, 131.0, 172.0, 132.0], "json-stringify-tinderbox": [71.0, 70.0, 69.0, 69.0, 69.0, 69.0, 70.0, 69.0, 70.0, 70.0], "stanford-crypto-pbkdf2": [136.0, 149.0, 155.0, 143.0, 149.0, 155.0, 161.0, 148.0, 151.0, 147.0], "json-parse-financial": [63.0, 63.0, 63.0, 61.0, 63.0, 63.0, 64.0, 68.0, 63.0, 62.0], "stanford-crypto-sha256-iterative": [66.0, 68.0, 66.0, 67.0, 67.0, 67.0, 73.0, 68.0, 67.0, 65.0], "audio-fft": [72.0, 72.0, 74.0, 151.0, 72.0, 72.0, 73.0, 73.0, 149.0, 74.0], "imaging-darkroom": [148.0, 146.0, 146.0, 146.0, 148.0, 147.0, 146.0, 147.0, 156.0, 150.0], "stanford-crypto-ccm": [116.0, 115.0, 116.0, 124.0, 119.0, 121.0, 125.0, 132.0, 132.0, 127.0], "audio-oscillator": [89.0, 91.0, 129.0, 90.0, 89.0, 89.0, 132.0, 90.0, 90.0, 140.0], "stanford-crypto-aes": [85.0, 92.0, 86.0, 85.0, 85.0, 92.0, 85.0, 85.0, 87.0, 85.0], "imaging-desaturate": [97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 96.0, 96.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1524.3000000000002, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 88.2, "unit": "ms", "value": 88.2}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 149.4, "unit": "ms", "value": 149.4}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 146.2, "unit": "ms", "value": 146.2}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 122.7, "unit": "ms", "value": 122.7}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 148.0, "unit": "ms", "value": 148.0}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 63.3, "unit": "ms", "value": 63.3}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 102.9, "unit": "ms", "value": 102.9}, "ai-astar": {"lowerIsBetter": true, "filtered": 111.2, "unit": "ms", "value": 111.2}, "audio-dft": {"lowerIsBetter": true, "filtered": 162.6, "unit": "ms", "value": 162.6}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 67.4, "unit": "ms", "value": 67.4}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.6, "unit": "ms", "value": 69.6}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.8, "unit": "ms", "value": 109.8}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 86.7, "unit": "ms", "value": 86.7}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.3, "unit": "ms", "value": 96.3}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-041.e"}, "testrun": {"date": 1447826311, "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": "20151117203118", "branch": "Fx-Team", "revision": "6fa3b2df62cc80058ea2f63834dcbdd6ec7caa36"}}, {"talos_counters": {}, "results": {"DeltaBlue": [191.60758766047135], "Encrypt": [282.08744710860367], "NavierStokes": [4854.368932038835], "Decrypt": [5040.201005025126], "Splay": [583.1395348837209], "Richards": [166.66666666666666], "RegExp": [26447.36842105263], "Earley": [713.2667617689016], "Boyer": [12207.317073170732], "RayTrace": [1059.322033898305]}, "summary": {"lowerIsBetter": false, "suite": 21372.5956914542, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 345.06984200000005, "unit": "score", "value": 345.06984200000005}, "Encrypt": {"lowerIsBetter": false, "filtered": 943.6116450000002, "unit": "score", "value": 943.6116450000002}, "NavierStokes": {"lowerIsBetter": false, "filtered": 305.7040000000001, "unit": "score", "value": 305.7040000000001}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.81158424725827, "unit": "score", "value": 52.81158424725827}, "Splay": {"lowerIsBetter": false, "filtered": 139.74528414755733, "unit": "score", "value": 139.74528414755733}, "RegExp": {"lowerIsBetter": false, "filtered": 34.44520398009948, "unit": "score", "value": 34.44520398009948}, "Richards": {"lowerIsBetter": false, "filtered": 211.81200000000004, "unit": "score", "value": 211.81200000000004}, "Earley": {"lowerIsBetter": false, "filtered": 934.3811260000003, "unit": "score", "value": 934.3811260000003}, "Boyer": {"lowerIsBetter": false, "filtered": 54.595370629370635, "unit": "score", "value": 54.595370629370635}, "RayTrace": {"lowerIsBetter": false, "filtered": 698.549616, "unit": "score", "value": 698.549616}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-041.e"}, "testrun": {"date": 1447826311, "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": "20151117203118", "branch": "Fx-Team", "revision": "6fa3b2df62cc80058ea2f63834dcbdd6ec7caa36"}}] 22:18:43 INFO - RETURN: dromaeo_css: 6742.50 22:18:43 INFO - RETURN: kraken: 1524.30 22:18:43 INFO - RETURN: v8_7: 21372.60 22:18:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21372.60"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1524.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6742.50"}}} 22:18:43 INFO - Return code: 0 22:18:43 INFO - # TBPL SUCCESS # 22:18:43 INFO - Running post-action listener: _resource_record_post_action 22:18:43 INFO - Running post-run listener: _resource_record_post_run 22:18:44 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 61440; Write bytes: 528564224; Read time: 324; Write time: 508960 22:18:44 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 177262592; Read time: 0; Write time: 248708 22:18:44 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 61440; Write bytes: 347361280; Read time: 324; Write time: 259516 22:18:44 INFO - Running post-run listener: _upload_blobber_files 22:18:44 INFO - Blob upload gear active. 22:18:44 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:18:44 INFO - Copying logs to upload dir... 22:18:44 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1260.470695 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2015-11-17 22:18:44.497017) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 22:18:44.500210) ========= 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=7f67ac1ceef7774224e327f2000001f6-1447826149.898596-1319257888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010022 build_url: 'https://queue.taskcluster.net/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/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 22:18:44.550229) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 22:18:44.550517) ========= 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=7f67ac1ceef7774224e327f2000001f6-1447826149.898596-1319257888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 22:18:44.599347) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 22:18:44.599632) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 22:18:44.599908) ========= ========= Total master_lag: 0.75 =========