builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-068 starttime: 1448513674.22 results: success (0) buildid: 20151125173020 builduid: 9de007e3ffd847dabac6890943cdea15 revision: 34c9087517ea31fc1a0204dd5635e7384a94ae3a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:34.219492) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:34.220418) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:34.220752) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1448513179.325936-1778087941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006416 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.47 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:34.700005) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:34.700332) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:34.830208) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:34.830522) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1448513179.325936-1778087941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.007879 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:34.890845) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:34.891189) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:34.891576) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:34.891901) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1448513179.325936-1778087941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-25 20:54:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 26.1M=0s 2015-11-25 20:54:35 (26.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156210 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:35.088055) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:35.088377) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1448513179.325936-1778087941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.050022 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:35.149431) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:35.149804) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 34c9087517ea31fc1a0204dd5635e7384a94ae3a --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 34c9087517ea31fc1a0204dd5635e7384a94ae3a --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=d7d9c069d1ebe471abe975fc000001d9-1448513179.325936-1778087941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-25 20:54:35,522 truncating revision to first 12 chars 2015-11-25 20:54:35,522 Setting DEBUG logging. 2015-11-25 20:54:35,522 attempt 1/10 2015-11-25 20:54:35,522 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/34c9087517ea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-25 20:54:35,769 unpacking tar archive at: fx-team-34c9087517ea/testing/mozharness/ program finished with exit code 0 elapsedTime=0.518435 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:35.680110) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:35.680417) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:35.691114) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:35.691403) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 20:54:35.691811) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2015-11-25 20:54:35.692174) ========= /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=d7d9c069d1ebe471abe975fc000001d9-1448513179.325936-1778087941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:54:36 INFO - MultiFileLogger online at 20151125 20:54:36 in /builds/slave/test-pgo 20:54:36 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 20:54:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 20:54:36 INFO - {'append_to_log': False, 20:54:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 20:54:36 INFO - 'blob_upload_branch': 'Fx-Team', 20:54:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 20:54:36 INFO - 'branch': 'Fx-Team', 20:54:36 INFO - 'buildbot_json_path': 'buildprops.json', 20:54:36 INFO - 'config_files': ('talos/linux_config.py',), 20:54:36 INFO - 'default_actions': ('clobber', 20:54:36 INFO - 'read-buildbot-config', 20:54:36 INFO - 'download-and-extract', 20:54:36 INFO - 'populate-webroot', 20:54:36 INFO - 'create-virtualenv', 20:54:36 INFO - 'install', 20:54:36 INFO - 'run-tests'), 20:54:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:54:36 INFO - 'download_minidump_stackwalk': True, 20:54:36 INFO - 'download_symbols': 'ondemand', 20:54:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:54:36 INFO - 'tooltool.py': '/tools/tooltool.py', 20:54:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:54:36 INFO - '/tools/misc-python/virtualenv.py')}, 20:54:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:54:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:54:36 INFO - 'installer_path': 'installer.exe', 20:54:36 INFO - 'log_level': 'info', 20:54:36 INFO - 'log_name': 'talos', 20:54:36 INFO - 'log_to_console': True, 20:54:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:54:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:54:36 INFO - 'opt_config_files': (), 20:54:36 INFO - 'pip_index': False, 20:54:36 INFO - 'sps_profile': False, 20:54:36 INFO - 'sps_profile_interval': 0, 20:54:36 INFO - 'suite': 'dromaeojs-e10s', 20:54:36 INFO - 'system_bits': '64', 20:54:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:54:36 INFO - 'title': 'talos-linux64-ix-068', 20:54:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:54:36 INFO - 'use_talos_json': True, 20:54:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 20:54:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:54:36 INFO - 'work_dir': 'build'} 20:54:36 INFO - ##### 20:54:36 INFO - ##### Running clobber step. 20:54:36 INFO - ##### 20:54:36 INFO - Running pre-action listener: _resource_record_pre_action 20:54:36 INFO - Running main action method: clobber 20:54:36 INFO - rmtree: /builds/slave/test-pgo/build 20:54:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 20:54:37 INFO - Running post-action listener: _resource_record_post_action 20:54:37 INFO - ##### 20:54:37 INFO - ##### Running read-buildbot-config step. 20:54:37 INFO - ##### 20:54:37 INFO - Running pre-action listener: _resource_record_pre_action 20:54:37 INFO - Running main action method: read_buildbot_config 20:54:37 INFO - Using buildbot properties: 20:54:37 INFO - { 20:54:37 INFO - "properties": { 20:54:37 INFO - "buildnumber": 358, 20:54:37 INFO - "product": "firefox", 20:54:37 INFO - "script_repo_revision": "production", 20:54:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:54:37 INFO - "repository": "", 20:54:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:54:37 INFO - "buildid": "20151125173020", 20:54:37 INFO - "slavename": "talos-linux64-ix-068", 20:54:37 INFO - "pgo_build": "True", 20:54:37 INFO - "basedir": "/builds/slave/test-pgo", 20:54:37 INFO - "project": "", 20:54:37 INFO - "platform": "ubuntu64_hw", 20:54:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:54:37 INFO - "slavebuilddir": "test", 20:54:37 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:54:37 INFO - "branch": "fx-team", 20:54:37 INFO - "repo_path": "integration/fx-team", 20:54:37 INFO - "stage_platform": "linux64-pgo", 20:54:37 INFO - "builduid": "9de007e3ffd847dabac6890943cdea15", 20:54:37 INFO - "revision": "34c9087517ea31fc1a0204dd5635e7384a94ae3a" 20:54:37 INFO - }, 20:54:37 INFO - "sourcestamp": { 20:54:37 INFO - "repository": "", 20:54:37 INFO - "hasPatch": false, 20:54:37 INFO - "project": "", 20:54:37 INFO - "branch": "fx-team-linux64-pgo-talos", 20:54:37 INFO - "changes": [ 20:54:37 INFO - { 20:54:37 INFO - "category": null, 20:54:37 INFO - "files": [ 20:54:37 INFO - { 20:54:37 INFO - "url": null, 20:54:37 INFO - "name": "https://queue.taskcluster.net/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 20:54:37 INFO - } 20:54:37 INFO - ], 20:54:37 INFO - "repository": "", 20:54:37 INFO - "rev": "34c9087517ea31fc1a0204dd5635e7384a94ae3a", 20:54:37 INFO - "who": "sendchange", 20:54:37 INFO - "when": 1448513650, 20:54:37 INFO - "number": 6708889, 20:54:37 INFO - "comments": "", 20:54:37 INFO - "project": "", 20:54:37 INFO - "at": "Wed 25 Nov 2015 20:54:10", 20:54:37 INFO - "branch": "fx-team-linux64-pgo-talos", 20:54:37 INFO - "revlink": "", 20:54:37 INFO - "properties": [ 20:54:37 INFO - [ 20:54:37 INFO - "buildid", 20:54:37 INFO - "20151125173020", 20:54:37 INFO - "Change" 20:54:37 INFO - ], 20:54:37 INFO - [ 20:54:37 INFO - "builduid", 20:54:37 INFO - "9de007e3ffd847dabac6890943cdea15", 20:54:37 INFO - "Change" 20:54:37 INFO - ], 20:54:37 INFO - [ 20:54:37 INFO - "pgo_build", 20:54:37 INFO - "True", 20:54:37 INFO - "Change" 20:54:37 INFO - ] 20:54:37 INFO - ], 20:54:37 INFO - "revision": "34c9087517ea31fc1a0204dd5635e7384a94ae3a" 20:54:37 INFO - } 20:54:37 INFO - ], 20:54:37 INFO - "revision": "34c9087517ea31fc1a0204dd5635e7384a94ae3a" 20:54:37 INFO - } 20:54:37 INFO - } 20:54:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 20:54:37 INFO - Running post-action listener: _resource_record_post_action 20:54:37 INFO - ##### 20:54:37 INFO - ##### Running download-and-extract step. 20:54:37 INFO - ##### 20:54:37 INFO - Running pre-action listener: _resource_record_pre_action 20:54:37 INFO - Running main action method: download_and_extract 20:54:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 20:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:54:37 INFO - https://queue.taskcluster.net/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:54:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/test_packages.json 20:54:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/test_packages.json 20:54:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 20:54:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 20:54:38 INFO - Downloaded 1302 bytes. 20:54:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 20:54:38 INFO - Using the following test package requirements: 20:54:38 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:54:38 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:54:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:54:38 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:54:38 INFO - u'jsshell-linux-x86_64.zip'], 20:54:38 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:54:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:54:38 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:54:38 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:54:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:54:38 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:54:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:54:38 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:54:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:54:38 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:54:38 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:54:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:54:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:54:38 INFO - https://queue.taskcluster.net/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:54:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:54:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:54:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/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 20:54:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/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 20:54:39 INFO - Downloaded 22754615 bytes. 20:54:39 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 20:54:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:54:39 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 20:54:40 INFO - Return code: 0 20:54:40 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 20:54:40 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')]} 20:54:40 INFO - https://queue.taskcluster.net/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:54:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:54:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:54:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/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 20:54:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/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 20:54:43 INFO - Downloaded 22754615 bytes. 20:54:43 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 20:54:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:54:43 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 20:54:45 INFO - Return code: 0 20:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:54:45 INFO - https://queue.taskcluster.net/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:54:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:54:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:54:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/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 20:54:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/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 20:54:46 INFO - Downloaded 11131717 bytes. 20:54:46 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 20:54:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:54:46 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 20:54:46 INFO - Return code: 0 20:54:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:54:46 INFO - https://queue.taskcluster.net/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:54:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:54:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:54:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/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 20:54:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AwZkoj0iQve-XkbXO1h25g/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 20:54:47 INFO - Downloaded 58393933 bytes. 20:54:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:54:47 INFO - mkdir: /builds/slave/test-pgo/properties 20:54:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 20:54:47 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 20:54:47 INFO - Contents: 20:54:47 INFO - build_url:https://queue.taskcluster.net/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:54:47 INFO - Running post-action listener: _resource_record_post_action 20:54:47 INFO - Running post-action listener: set_extra_try_arguments 20:54:47 INFO - ##### 20:54:47 INFO - ##### Running populate-webroot step. 20:54:47 INFO - ##### 20:54:47 INFO - Running pre-action listener: _resource_record_pre_action 20:54:47 INFO - Running main action method: populate_webroot 20:54:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:54:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:54:47 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 20:54:47 INFO - '../fennec_ids.txt'], 20:54:47 INFO - 'tests': ['tcheck2']}, 20:54:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:54:47 INFO - '--tppagecycles', 20:54:47 INFO - '7'], 20:54:47 INFO - 'tests': ['tsvgm']}}, 20:54:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:54:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:54:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:54:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:54:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:54:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:54:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:54:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:54:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:54:47 INFO - 'talos_options': ['--e10s'], 20:54:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:54:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:54:47 INFO - 'tests': ['damp', 'tps']}, 20:54:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:54:47 INFO - 'talos_options': ['--e10s'], 20:54:47 INFO - 'tests': ['damp', 'tps']}, 20:54:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:54:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:54:47 INFO - 'other': {'tests': ['a11yr', 20:54:47 INFO - 'ts_paint', 20:54:47 INFO - 'tpaint', 20:54:47 INFO - 'sessionrestore', 20:54:47 INFO - 'sessionrestore_no_auto_restore']}, 20:54:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:54:47 INFO - 'tests': ['a11yr', 20:54:47 INFO - 'ts_paint', 20:54:47 INFO - 'tpaint', 20:54:47 INFO - 'sessionrestore', 20:54:47 INFO - 'sessionrestore_no_auto_restore']}, 20:54:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:54:47 INFO - 'tests': ['a11yr', 20:54:47 INFO - 'ts_paint', 20:54:47 INFO - 'tpaint', 20:54:47 INFO - 'sessionrestore', 20:54:47 INFO - 'sessionrestore_no_auto_restore']}, 20:54:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:54:47 INFO - 'tests': ['a11yr', 20:54:47 INFO - 'ts_paint', 20:54:47 INFO - 'tpaint', 20:54:47 INFO - 'sessionrestore', 20:54:47 INFO - 'sessionrestore_no_auto_restore']}, 20:54:47 INFO - 'other_l64': {'tests': ['a11yr', 20:54:47 INFO - 'ts_paint', 20:54:47 INFO - 'tpaint', 20:54:47 INFO - 'sessionrestore', 20:54:47 INFO - 'sessionrestore_no_auto_restore']}, 20:54:47 INFO - 'other_nol64': {'tests': ['a11yr', 20:54:47 INFO - 'ts_paint', 20:54:47 INFO - 'tpaint', 20:54:47 INFO - 'sessionrestore', 20:54:47 INFO - 'sessionrestore_no_auto_restore']}, 20:54:47 INFO - 'svgr': {'tests': ['tsvgx', 20:54:47 INFO - 'tsvgr_opacity', 20:54:47 INFO - 'tart', 20:54:47 INFO - 'tscrollx', 20:54:47 INFO - 'cart']}, 20:54:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:54:47 INFO - 'tests': ['tsvgx', 20:54:47 INFO - 'tsvgr_opacity', 20:54:47 INFO - 'tart', 20:54:47 INFO - 'tscrollx', 20:54:47 INFO - 'cart']}, 20:54:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:54:47 INFO - 'tests': ['tp5o']}, 20:54:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:54:47 INFO - 'talos_options': ['--e10s'], 20:54:47 INFO - 'tests': ['tp5o']}, 20:54:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:54:47 INFO - 'talos_options': ['--xperf_path', 20:54:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:54:47 INFO - 'tests': ['tp5n']}, 20:54:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:54:47 INFO - 'talos_options': ['--e10s', 20:54:47 INFO - '--xperf_path', 20:54:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:54:47 INFO - 'tests': ['tp5n']}}, 20:54:47 INFO - 'talos.zip': {'path': '', 20:54:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:54:47 INFO - Running post-action listener: _resource_record_post_action 20:54:47 INFO - ##### 20:54:47 INFO - ##### Running create-virtualenv step. 20:54:47 INFO - ##### 20:54:47 INFO - Running pre-action listener: _resource_record_pre_action 20:54:47 INFO - Running main action method: create_virtualenv 20:54:47 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 20:54:47 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 20:54:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 20:54:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:54:47 INFO - Using real prefix '/usr' 20:54:47 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 20:54:48 INFO - Installing distribute.............................................................................................................................................................................................done. 20:54:50 INFO - Installing pip.................done. 20:54:50 INFO - Return code: 0 20:54:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 20:54: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')]} 20:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:54:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:54: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')]} 20:54:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:54:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:54:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad57d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b64640>, '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 0x1b65540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b659d0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1448513179.325936-1778087941', '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 20:54:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 20:54:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:54:50 INFO - Using env: {'DISPLAY': ':0', 20:54:50 INFO - 'HOME': '/home/cltbld', 20:54:50 INFO - 'LANG': 'en_US.UTF-8', 20:54:50 INFO - 'LANGUAGE': 'en_US:en', 20:54:50 INFO - 'LOGNAME': 'cltbld', 20:54:50 INFO - 'MAIL': '/var/mail/cltbld', 20:54:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:54:50 INFO - 'MOZ_NO_REMOTE': '1', 20:54:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:54:50 INFO - 'NO_EM_RESTART': '1', 20:54:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:54:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:54:50 INFO - 'PWD': '/builds/slave/test-pgo', 20:54:50 INFO - 'SHELL': '/bin/bash', 20:54:50 INFO - 'SHLVL': '1', 20:54:50 INFO - 'TERM': 'linux', 20:54:50 INFO - 'TMOUT': '86400', 20:54:50 INFO - 'USER': 'cltbld', 20:54:50 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1448513179.325936-1778087941', 20:54:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:54:50 INFO - '_': '/tools/buildbot/bin/python'} 20:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:54:51 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 20:54:51 INFO - Cleaning up... 20:54:51 INFO - Return code: 0 20:54:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 20:54: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')]} 20:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:54: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')]} 20:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:54:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x18a8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad57d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b64640>, '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 0x1b65540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b659d0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1448513179.325936-1778087941', '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 20:54:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 20:54:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 20:54:51 INFO - Using env: {'DISPLAY': ':0', 20:54:51 INFO - 'HOME': '/home/cltbld', 20:54:51 INFO - 'LANG': 'en_US.UTF-8', 20:54:51 INFO - 'LANGUAGE': 'en_US:en', 20:54:51 INFO - 'LOGNAME': 'cltbld', 20:54:51 INFO - 'MAIL': '/var/mail/cltbld', 20:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:54:51 INFO - 'MOZ_NO_REMOTE': '1', 20:54:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:54:51 INFO - 'NO_EM_RESTART': '1', 20:54:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:54:51 INFO - 'PWD': '/builds/slave/test-pgo', 20:54:51 INFO - 'SHELL': '/bin/bash', 20:54:51 INFO - 'SHLVL': '1', 20:54:51 INFO - 'TERM': 'linux', 20:54:51 INFO - 'TMOUT': '86400', 20:54:51 INFO - 'USER': 'cltbld', 20:54:51 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1448513179.325936-1778087941', 20:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:54:51 INFO - '_': '/tools/buildbot/bin/python'} 20:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:54:51 INFO - Downloading/unpacking psutil>=0.7.1 20:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:54:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:54:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:54:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:54:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:54:53 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 20:54:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 20:54:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 20:54:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:54:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:54:53 INFO - Installing collected packages: psutil 20:54:53 INFO - Running setup.py install for psutil 20:54:53 INFO - building 'psutil._psutil_linux' extension 20:54:53 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 20:54:53 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 20:54:53 INFO - building 'psutil._psutil_posix' extension 20:54:53 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 20:54:53 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 20:54:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:54:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:54:53 INFO - Successfully installed psutil 20:54:53 INFO - Cleaning up... 20:54:53 INFO - Return code: 0 20:54:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 20:54:53 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')]} 20:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:54:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:54:53 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')]} 20:54:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:54:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:54:53 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 0x18a8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad57d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b64640>, '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 0x1b65540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b659d0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1448513179.325936-1778087941', '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 20:54:53 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 20:54:53 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 20:54:53 INFO - Using env: {'DISPLAY': ':0', 20:54:53 INFO - 'HOME': '/home/cltbld', 20:54:53 INFO - 'LANG': 'en_US.UTF-8', 20:54:53 INFO - 'LANGUAGE': 'en_US:en', 20:54:53 INFO - 'LOGNAME': 'cltbld', 20:54:53 INFO - 'MAIL': '/var/mail/cltbld', 20:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:54:53 INFO - 'MOZ_NO_REMOTE': '1', 20:54:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:54:53 INFO - 'NO_EM_RESTART': '1', 20:54:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:54:53 INFO - 'PWD': '/builds/slave/test-pgo', 20:54:53 INFO - 'SHELL': '/bin/bash', 20:54:53 INFO - 'SHLVL': '1', 20:54:53 INFO - 'TERM': 'linux', 20:54:53 INFO - 'TMOUT': '86400', 20:54:53 INFO - 'USER': 'cltbld', 20:54:53 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1448513179.325936-1778087941', 20:54:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:54:53 INFO - '_': '/tools/buildbot/bin/python'} 20:54:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:54:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:54:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:54:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:54:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:54:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:54:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:54:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 20:54:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:54:55 INFO - Installing collected packages: mozsystemmonitor 20:54:55 INFO - Running setup.py install for mozsystemmonitor 20:54:56 INFO - Successfully installed mozsystemmonitor 20:54:56 INFO - Cleaning up... 20:54:56 INFO - Return code: 0 20:54:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 20:54: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')]} 20:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:54:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:54: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')]} 20:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:54:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:54:56 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 0x18a8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad57d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b64640>, '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 0x1b65540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b659d0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1448513179.325936-1778087941', '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 20:54:56 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 20:54:56 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 20:54:56 INFO - Using env: {'DISPLAY': ':0', 20:54:56 INFO - 'HOME': '/home/cltbld', 20:54:56 INFO - 'LANG': 'en_US.UTF-8', 20:54:56 INFO - 'LANGUAGE': 'en_US:en', 20:54:56 INFO - 'LOGNAME': 'cltbld', 20:54:56 INFO - 'MAIL': '/var/mail/cltbld', 20:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:54:56 INFO - 'MOZ_NO_REMOTE': '1', 20:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:54:56 INFO - 'NO_EM_RESTART': '1', 20:54:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:54:56 INFO - 'PWD': '/builds/slave/test-pgo', 20:54:56 INFO - 'SHELL': '/bin/bash', 20:54:56 INFO - 'SHLVL': '1', 20:54:56 INFO - 'TERM': 'linux', 20:54:56 INFO - 'TMOUT': '86400', 20:54:56 INFO - 'USER': 'cltbld', 20:54:56 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1448513179.325936-1778087941', 20:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:54:56 INFO - '_': '/tools/buildbot/bin/python'} 20:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:54:56 INFO - Downloading/unpacking blobuploader==1.2.4 20:54:56 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 20:54:56 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 20:54:56 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 20:54:56 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 20:54:56 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 20:54:56 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 20:54:58 INFO - Downloading blobuploader-1.2.4.tar.gz 20:54:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 20:54:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:54:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:54:58 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 20:54:58 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 20:54:58 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 20:54:58 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 20:54:58 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 20:54:58 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 20:54:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 20:54:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 20:54:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:54:58 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 20:54:58 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 20:54:58 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 20:54:58 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 20:54:58 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 20:54:58 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 20:54:58 INFO - Downloading docopt-0.6.1.tar.gz 20:54:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 20:54:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 20:54:58 INFO - Installing collected packages: blobuploader, requests, docopt 20:54:58 INFO - Running setup.py install for blobuploader 20:54:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:54:58 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 20:54:59 INFO - Running setup.py install for requests 20:54:59 INFO - Running setup.py install for docopt 20:54:59 INFO - Successfully installed blobuploader requests docopt 20:54:59 INFO - Cleaning up... 20:54:59 INFO - Return code: 0 20:54:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:54:59 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 0x18a8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad57d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b64640>, '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 0x1b65540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b659d0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1448513179.325936-1778087941', '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 20:54:59 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 20:54:59 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 20:54:59 INFO - Using env: {'DISPLAY': ':0', 20:54:59 INFO - 'HOME': '/home/cltbld', 20:54:59 INFO - 'LANG': 'en_US.UTF-8', 20:54:59 INFO - 'LANGUAGE': 'en_US:en', 20:54:59 INFO - 'LOGNAME': 'cltbld', 20:54:59 INFO - 'MAIL': '/var/mail/cltbld', 20:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:54:59 INFO - 'MOZ_NO_REMOTE': '1', 20:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:54:59 INFO - 'NO_EM_RESTART': '1', 20:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:54:59 INFO - 'PWD': '/builds/slave/test-pgo', 20:54:59 INFO - 'SHELL': '/bin/bash', 20:54:59 INFO - 'SHLVL': '1', 20:54:59 INFO - 'TERM': 'linux', 20:54:59 INFO - 'TMOUT': '86400', 20:54:59 INFO - 'USER': 'cltbld', 20:54:59 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1448513179.325936-1778087941', 20:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:54:59 INFO - '_': '/tools/buildbot/bin/python'} 20:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:54:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:54:59 INFO - Running setup.py (path:/tmp/pip-xPZb13-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:54:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:54:59 INFO - Running setup.py (path:/tmp/pip-jWfZml-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:54:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:54:59 INFO - Running setup.py (path:/tmp/pip-iJ3Uo3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:54:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:54:59 INFO - Running setup.py (path:/tmp/pip-2bY3n9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:54:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:55:00 INFO - Running setup.py (path:/tmp/pip-1KkEv0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:55:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:55:00 INFO - Running setup.py (path:/tmp/pip-0o0NUe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:55:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:55:00 INFO - Running setup.py (path:/tmp/pip-t50N1n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:55:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:55:00 INFO - Running setup.py (path:/tmp/pip-FHo4lv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:55:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:55:00 INFO - Running setup.py (path:/tmp/pip-F6yyye-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:55:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:55:00 INFO - Running setup.py (path:/tmp/pip-muZLyU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:55:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:55:00 INFO - Running setup.py (path:/tmp/pip-0D5vR8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:55:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:55:00 INFO - Running setup.py (path:/tmp/pip-Sris_K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:55:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:55:00 INFO - Running setup.py (path:/tmp/pip-t4o1vJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:55:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:55:00 INFO - Running setup.py (path:/tmp/pip-H2TL7C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:55:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:55:00 INFO - Running setup.py (path:/tmp/pip-TVzW0H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:55:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:55:00 INFO - Running setup.py (path:/tmp/pip-krw23y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:55:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:55:00 INFO - Running setup.py (path:/tmp/pip-WPAJwk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:55:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:55:00 INFO - Running setup.py install for manifestparser 20:55:01 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 20:55:01 INFO - Running setup.py install for mozcrash 20:55:01 INFO - Running setup.py install for mozdebug 20:55:01 INFO - Running setup.py install for mozdevice 20:55:01 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 20:55:01 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 20:55:01 INFO - Running setup.py install for mozfile 20:55:01 INFO - Running setup.py install for mozhttpd 20:55:01 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 20:55:01 INFO - Running setup.py install for mozinfo 20:55:01 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 20:55:01 INFO - Running setup.py install for mozInstall 20:55:01 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 20:55:01 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 20:55:01 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 20:55:01 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 20:55:01 INFO - Running setup.py install for mozleak 20:55:01 INFO - Running setup.py install for mozlog 20:55:01 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 20:55:01 INFO - Running setup.py install for moznetwork 20:55:02 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 20:55:02 INFO - Running setup.py install for mozprocess 20:55:02 INFO - Running setup.py install for mozprofile 20:55:02 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 20:55:02 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 20:55:02 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 20:55:02 INFO - Running setup.py install for mozrunner 20:55:02 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 20:55:02 INFO - Running setup.py install for mozscreenshot 20:55:02 INFO - Running setup.py install for moztest 20:55:02 INFO - Running setup.py install for mozversion 20:55:02 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 20:55:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:55:02 INFO - Cleaning up... 20:55:02 INFO - Return code: 0 20:55:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:55: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')]} 20:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:55:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55: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')]} 20:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:55:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x18a8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad57d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b64640>, '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 0x1b65540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b659d0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1448513179.325936-1778087941', '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 20:55:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 20:55:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 20:55:02 INFO - Using env: {'DISPLAY': ':0', 20:55:02 INFO - 'HOME': '/home/cltbld', 20:55:02 INFO - 'LANG': 'en_US.UTF-8', 20:55:02 INFO - 'LANGUAGE': 'en_US:en', 20:55:02 INFO - 'LOGNAME': 'cltbld', 20:55:02 INFO - 'MAIL': '/var/mail/cltbld', 20:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:55:02 INFO - 'MOZ_NO_REMOTE': '1', 20:55:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:55:02 INFO - 'NO_EM_RESTART': '1', 20:55:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:55:02 INFO - 'PWD': '/builds/slave/test-pgo', 20:55:02 INFO - 'SHELL': '/bin/bash', 20:55:02 INFO - 'SHLVL': '1', 20:55:02 INFO - 'TERM': 'linux', 20:55:02 INFO - 'TMOUT': '86400', 20:55:02 INFO - 'USER': 'cltbld', 20:55:02 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1448513179.325936-1778087941', 20:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:55:02 INFO - '_': '/tools/buildbot/bin/python'} 20:55:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:55:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:55:02 INFO - Running setup.py (path:/tmp/pip-twYQ4Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:55:03 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)) 20:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:55:03 INFO - Running setup.py (path:/tmp/pip-ibjOC_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:55:03 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)) 20:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:55:03 INFO - Running setup.py (path:/tmp/pip-RA1HjP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:55:03 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)) 20:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:55:03 INFO - Running setup.py (path:/tmp/pip-6Fe9FF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:55:03 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)) 20:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:55:03 INFO - Running setup.py (path:/tmp/pip-mulKhM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:55:03 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)) 20:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:55:03 INFO - Running setup.py (path:/tmp/pip-1NIhkp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:55:03 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)) 20:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:55:03 INFO - Running setup.py (path:/tmp/pip-Q8DEx1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:55:03 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)) 20:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:55:03 INFO - Running setup.py (path:/tmp/pip-0UiH6r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:55:03 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)) 20:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:55:03 INFO - Running setup.py (path:/tmp/pip-XgyGco-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:55:03 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)) 20:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:55:03 INFO - Running setup.py (path:/tmp/pip-YDnKaM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:55:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 20:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:55:03 INFO - Running setup.py (path:/tmp/pip-ZvPuvI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:55:03 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)) 20:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:55:03 INFO - Running setup.py (path:/tmp/pip-fuzV2k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:55:03 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)) 20:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:55:03 INFO - Running setup.py (path:/tmp/pip-z4Y7oP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:55:03 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)) 20:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:55:03 INFO - Running setup.py (path:/tmp/pip-99j4ZG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:55:03 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)) 20:55:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:55:03 INFO - Running setup.py (path:/tmp/pip-DXKa0A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:55:04 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)) 20:55:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:55:04 INFO - Running setup.py (path:/tmp/pip-sDLOKO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:55:04 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)) 20:55:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:55:04 INFO - Running setup.py (path:/tmp/pip-JBqs8k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:55:04 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)) 20:55:04 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)) 20:55:04 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)) 20:55:04 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)) 20:55:04 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)) 20:55:04 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)) 20:55:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 20:55: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 20:55: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 20:55: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 20:55: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 20:55: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 20:55: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 20:55:05 INFO - Downloading blessings-1.5.1.tar.gz 20:55:05 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 20:55:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 20:55:05 INFO - Installing collected packages: blessings 20:55:05 INFO - Running setup.py install for blessings 20:55:06 INFO - Successfully installed blessings 20:55:06 INFO - Cleaning up... 20:55:06 INFO - Return code: 0 20:55:06 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 20:55:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:55:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:55:06 INFO - Reading from file tmpfile_stdout 20:55:06 INFO - Current package versions: 20:55:06 INFO - argparse == 1.2.1 20:55:06 INFO - blessings == 1.5.1 20:55:06 INFO - blobuploader == 1.2.4 20:55:06 INFO - docopt == 0.6.1 20:55:06 INFO - manifestparser == 1.1 20:55:06 INFO - mozInstall == 1.12 20:55:06 INFO - mozcrash == 0.16 20:55:06 INFO - mozdebug == 0.1 20:55:06 INFO - mozdevice == 0.47 20:55:06 INFO - mozfile == 1.2 20:55:06 INFO - mozhttpd == 0.7 20:55:06 INFO - mozinfo == 0.9 20:55:06 INFO - mozleak == 0.1 20:55:06 INFO - mozlog == 3.1 20:55:06 INFO - moznetwork == 0.27 20:55:06 INFO - mozprocess == 0.22 20:55:06 INFO - mozprofile == 0.27 20:55:06 INFO - mozrunner == 6.11 20:55:06 INFO - mozscreenshot == 0.1 20:55:06 INFO - mozsystemmonitor == 0.0 20:55:06 INFO - moztest == 0.7 20:55:06 INFO - mozversion == 1.4 20:55:06 INFO - psutil == 3.1.1 20:55:06 INFO - requests == 1.2.3 20:55:06 INFO - wsgiref == 0.1.2 20:55:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:55: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')]} 20:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:55:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55: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')]} 20:55:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:55:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55: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', '-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 0x18a8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad57d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b64640>, '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 0x1b65540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b659d0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1448513179.325936-1778087941', '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 20:55:06 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 20:55:06 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 20:55:06 INFO - Using env: {'DISPLAY': ':0', 20:55:06 INFO - 'HOME': '/home/cltbld', 20:55:06 INFO - 'LANG': 'en_US.UTF-8', 20:55:06 INFO - 'LANGUAGE': 'en_US:en', 20:55:06 INFO - 'LOGNAME': 'cltbld', 20:55:06 INFO - 'MAIL': '/var/mail/cltbld', 20:55:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:55:06 INFO - 'MOZ_NO_REMOTE': '1', 20:55:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:55:06 INFO - 'NO_EM_RESTART': '1', 20:55:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:55:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:55:06 INFO - 'PWD': '/builds/slave/test-pgo', 20:55:06 INFO - 'SHELL': '/bin/bash', 20:55:06 INFO - 'SHLVL': '1', 20:55:06 INFO - 'TERM': 'linux', 20:55:06 INFO - 'TMOUT': '86400', 20:55:06 INFO - 'USER': 'cltbld', 20:55:06 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1448513179.325936-1778087941', 20:55:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:55:06 INFO - '_': '/tools/buildbot/bin/python'} 20:55:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:55:06 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)) 20:55:06 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)) 20:55:06 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)) 20:55:06 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)) 20:55:06 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)) 20:55:06 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)) 20:55:06 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)) 20:55:06 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)) 20:55:06 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)) 20:55:06 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)) 20:55:06 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)) 20:55:06 INFO - Cleaning up... 20:55:06 INFO - Return code: 0 20:55:06 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 20:55: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')]} 20:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:55:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55: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')]} 20:55:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:55:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad57d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b64640>, '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 0x1b65540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b659d0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1448513179.325936-1778087941', '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 20:55: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', 'jsonschema'] in /builds/slave/test-pgo/build 20:55: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 jsonschema 20:55:06 INFO - Using env: {'DISPLAY': ':0', 20:55:06 INFO - 'HOME': '/home/cltbld', 20:55:06 INFO - 'LANG': 'en_US.UTF-8', 20:55:06 INFO - 'LANGUAGE': 'en_US:en', 20:55:06 INFO - 'LOGNAME': 'cltbld', 20:55:06 INFO - 'MAIL': '/var/mail/cltbld', 20:55:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:55:06 INFO - 'MOZ_NO_REMOTE': '1', 20:55:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:55:06 INFO - 'NO_EM_RESTART': '1', 20:55:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:55:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:55:06 INFO - 'PWD': '/builds/slave/test-pgo', 20:55:06 INFO - 'SHELL': '/bin/bash', 20:55:06 INFO - 'SHLVL': '1', 20:55:06 INFO - 'TERM': 'linux', 20:55:06 INFO - 'TMOUT': '86400', 20:55:06 INFO - 'USER': 'cltbld', 20:55:06 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1448513179.325936-1778087941', 20:55:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:55:06 INFO - '_': '/tools/buildbot/bin/python'} 20:55:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:55:06 INFO - Downloading/unpacking jsonschema 20:55: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 20:55: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 20:55: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 20:55: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 20:55: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 20:55: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 20:55:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:55:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 20:55:08 INFO - Downloading/unpacking functools32 (from jsonschema) 20:55: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 20:55: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 20:55: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 20:55: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 20:55: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 20:55: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 20:55:08 INFO - Downloading functools32-3.2.3-2.tar.gz 20:55:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 20:55:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 20:55:08 INFO - warning: no files found matching '*.txt' 20:55:08 INFO - no previously-included directories found matching 'build' 20:55:08 INFO - no previously-included directories found matching 'dist' 20:55:08 INFO - no previously-included directories found matching '.git*' 20:55:08 INFO - Installing collected packages: jsonschema, functools32 20:55:08 INFO - Running setup.py install for functools32 20:55:08 INFO - warning: no files found matching '*.txt' 20:55:08 INFO - no previously-included directories found matching 'build' 20:55:08 INFO - no previously-included directories found matching 'dist' 20:55:08 INFO - no previously-included directories found matching '.git*' 20:55:08 INFO - Successfully installed jsonschema functools32 20:55:08 INFO - Cleaning up... 20:55:08 INFO - Return code: 0 20:55:08 INFO - Running post-action listener: _resource_record_post_action 20:55:08 INFO - Running post-action listener: _start_resource_monitoring 20:55:08 INFO - Starting resource monitoring. 20:55:08 INFO - ##### 20:55:08 INFO - ##### Running install step. 20:55:08 INFO - ##### 20:55:08 INFO - Running pre-action listener: _resource_record_pre_action 20:55:08 INFO - Running main action method: install 20:55:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:55:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:55:09 INFO - Reading from file tmpfile_stdout 20:55:09 INFO - Detecting whether we're running mozinstall >=1.0... 20:55:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 20:55:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 20:55:09 INFO - Reading from file tmpfile_stdout 20:55:09 INFO - Output received: 20:55:09 INFO - Usage: mozinstall [options] installer 20:55:09 INFO - Options: 20:55:09 INFO - -h, --help show this help message and exit 20:55:09 INFO - -d DEST, --destination=DEST 20:55:09 INFO - Directory to install application into. [default: 20:55:09 INFO - "/builds/slave/test-pgo"] 20:55:09 INFO - --app=APP Application being installed. [default: firefox] 20:55:09 INFO - mkdir: /builds/slave/test-pgo/build/application 20:55:09 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'] 20:55:09 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 20:55:23 INFO - Reading from file tmpfile_stdout 20:55:23 INFO - Output received: 20:55:23 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 20:55:23 INFO - Running post-action listener: _resource_record_post_action 20:55:23 INFO - ##### 20:55:23 INFO - ##### Running run-tests step. 20:55:23 INFO - ##### 20:55:23 INFO - Running pre-action listener: _resource_record_pre_action 20:55:23 INFO - Running main action method: run_tests 20:55:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 20:55:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 20:55:23 INFO - Python 2.7.3 20:55:23 INFO - Return code: 0 20:55:23 INFO - grabbing minidump binary from tooltool 20:55:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:55:23 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 0x1b64640>, '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 0x1b65540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b659d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 20:55:23 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 20:55:23 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 20:55:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:55:23 INFO - Return code: 0 20:55:23 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 20:55:23 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 20:55:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 20:55:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 20:55:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 20:55:23 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/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 20:55:23 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/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost 20:55:23 INFO - Using env: {'DISPLAY': ':0', 20:55:23 INFO - 'HOME': '/home/cltbld', 20:55:23 INFO - 'LANG': 'en_US.UTF-8', 20:55:23 INFO - 'LANGUAGE': 'en_US:en', 20:55:23 INFO - 'LOGNAME': 'cltbld', 20:55:23 INFO - 'MAIL': '/var/mail/cltbld', 20:55:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:55:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 20:55:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:55:23 INFO - 'MOZ_NO_REMOTE': '1', 20:55:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:55:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:55:23 INFO - 'NO_EM_RESTART': '1', 20:55:23 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:55:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:55:23 INFO - 'PWD': '/builds/slave/test-pgo', 20:55:23 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 20:55:23 INFO - 'SHELL': '/bin/bash', 20:55:23 INFO - 'SHLVL': '1', 20:55:23 INFO - 'TERM': 'linux', 20:55:23 INFO - 'TMOUT': '86400', 20:55:23 INFO - 'USER': 'cltbld', 20:55:23 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1448513179.325936-1778087941', 20:55:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:55:23 INFO - '_': '/tools/buildbot/bin/python'} 20:55:23 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/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost'] with output_timeout 3600 20:55:24 INFO - mozversion INFO | application_buildid: 20151125173020 20:55:24 INFO - mozversion INFO | application_changeset: 34c9087517ea31fc1a0204dd5635e7384a94ae3a 20:55:24 INFO - mozversion INFO | application_display_name: Nightly 20:55:24 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:55:24 INFO - mozversion INFO | application_name: Firefox 20:55:24 INFO - mozversion INFO | application_remotingname: firefox 20:55:24 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 20:55:24 INFO - mozversion INFO | application_vendor: Mozilla 20:55:24 INFO - mozversion INFO | application_version: 45.0a1 20:55:24 INFO - mozversion INFO | platform_buildid: 20151125173020 20:55:24 INFO - mozversion INFO | platform_changeset: 34c9087517ea31fc1a0204dd5635e7384a94ae3a 20:55:24 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 20:55:24 INFO - mozversion INFO | platform_version: 45.0a1 20:55:24 INFO - 2015-11-25 20:55:24,102 DEBUG : using testdate: 1448513724 20:55:24 INFO - 2015-11-25 20:55:24,102 DEBUG : actual date: 1448513724 20:55:24 INFO - 2015-11-25 20:55:24,150 INFO : starting webserver on 'localhost:40704' 20:55:24 INFO - 2015-11-25 20:55:24,151 INFO : Starting test suite talos-linux64-ix-068.e 20:55:24 INFO - 2015-11-25 20:55:24,151 INFO : Starting test dromaeo_css 20:55:24 INFO - 2015-11-25 20:55:24,151 DEBUG : operating with platform_type : linux_ 20:55:24 INFO - 2015-11-25 20:55:24,152 INFO : Initialising browser for dromaeo_css test... 20:55:24 INFO - 2015-11-25 20:55:24,166 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpb8UnhC/profile http://localhost:40704/getInfo.html 20:55:28 INFO - 2015-11-25 20:55:28,638 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:55:28 INFO - 2015-11-25 20:55:28,638 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:55:28 INFO - 2015-11-25 20:55:28,638 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:55:28 INFO - 2015-11-25 20:55:28,638 DEBUG : BROWSER_OUTPUT: __metrics 20:55:29 INFO - 2015-11-25 20:55:29,641 INFO : Browser initialized. 20:55:29 INFO - 2015-11-25 20:55:29,642 INFO : Running cycle 1/1 for dromaeo_css test... 20:55:29 INFO - 2015-11-25 20:55:29,642 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpb8UnhC/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:55:41 INFO - 2015-11-25 20:55:41,408 DEBUG : BROWSER_OUTPUT: RSS: Main: 138219520 20:55:41 INFO - 2015-11-25 20:55:41,408 DEBUG : BROWSER_OUTPUT: 20:56:31 INFO - 2015-11-25 20:56:31,016 DEBUG : BROWSER_OUTPUT: 1448513791015 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] 20:58:40 INFO - 2015-11-25 20:58:40,478 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40704/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40704/tests/dromaeo/cssquery-ext.html) 20:58:41 INFO - 2015-11-25 20:58:41,528 DEBUG : BROWSER_OUTPUT: RSS: Main: 147099648 20:58:41 INFO - 2015-11-25 20:58:41,528 DEBUG : BROWSER_OUTPUT: 21:01:43 INFO - 2015-11-25 21:01:43,436 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40704/tests/dromaeo/cssquery-ext.html (next: http://localhost:40704/tests/dromaeo/cssquery-jquery.html) 21:01:44 INFO - 2015-11-25 21:01:44,037 DEBUG : BROWSER_OUTPUT: RSS: Main: 141856768 21:01:44 INFO - 2015-11-25 21:01:44,037 DEBUG : BROWSER_OUTPUT: 21:04:45 INFO - 2015-11-25 21:04:45,723 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40704/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40704/tests/dromaeo/cssquery-mootools.html) 21:04:46 INFO - 2015-11-25 21:04:46,304 DEBUG : BROWSER_OUTPUT: RSS: Main: 143970304 21:04:46 INFO - 2015-11-25 21:04:46,304 DEBUG : BROWSER_OUTPUT: 21:07:47 INFO - 2015-11-25 21:07:47,977 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40704/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40704/tests/dromaeo/cssquery-prototype.html) 21:07:48 INFO - 2015-11-25 21:07:48,563 DEBUG : BROWSER_OUTPUT: RSS: Main: 142450688 21:07:48 INFO - 2015-11-25 21:07:48,563 DEBUG : BROWSER_OUTPUT: 21:10:50 INFO - 2015-11-25 21:10:50,855 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40704/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40704/tests/dromaeo/cssquery-yui.html) 21:10:51 INFO - 2015-11-25 21:10:51,476 DEBUG : BROWSER_OUTPUT: RSS: Main: 143065088 21:10:51 INFO - 2015-11-25 21:10:51,477 DEBUG : BROWSER_OUTPUT: 21:13:54 INFO - 2015-11-25 21:13:54,073 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40704/tests/dromaeo/cssquery-yui.html (next: http://localhost:40704/tests/dromaeo/cssquery-dojo.html) 21:13:54 INFO - 2015-11-25 21:13:54,323 DEBUG : BROWSER_OUTPUT: RSS: Main: 144871424 21:13:54 INFO - 2015-11-25 21:13:54,323 DEBUG : BROWSER_OUTPUT: 21:13:54 INFO - 2015-11-25 21:13:54,325 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:13:54 INFO - 2015-11-25 21:13:54,325 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:13:54 INFO - 2015-11-25 21:13:54,325 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:13:54 INFO - 2015-11-25 21:13:54,325 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:13:54 INFO - 2015-11-25 21:13:54,325 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3225.193701574606;3281.8030918144914;3294.1105901406604;3322.451795453751;3340.1315657928944;5256.053910296155;5408.972955135224;5438.8912221755545;5462.453754624536;5476.616636835418;5340.759665815038;5387.353517577896;5420.4850539198715;5421.457854214576;5439.292891924054;4682.742449165295;4976.502349765031;5025.0703619830265;5040.747962601874;5082.745862706868;4848.224284114543;5000.899982000358;5008.699478031312;5050.595952323823;5063.8480845574695;4760.8333708320215;4931.531504507102;4945;4969.055879382906;4971.254311853215;4987.476314986947;5033.697978121324;5048.040872234264;5063.594912406998;5086.262491938648;4784.186688263004;4870.805167793284;4984.700917944935;4994.82518111868;5092.185250359925;4997.575206107485;5219.243209734605;5241.580673546107;5309.203619457074;5385.865353366158;5903.439173278532;5910.113482977587;5921;5933.169356290123;5935.970320148414;5726.5705072119345;5865.736041878125;5866.530677545828;5950.256217972754;5994.220751302347;5450.727463626803;5468.316460442445;5504.6421982571;5505.559555235612;5508.14623733318;5877;5885.323187833368;5940.257467816523;5942;5954.940450595525;5866.560007999417;5873.442023007808;5881.382454842265;5893.027650437715;5920.378360272195;5860.09168578871;5922.200502932049;5959.970200148971;5962.791302304398;5974.253218347707;5672.602917795797;5817.389174136655;5825.2135961644635;5927.9407205928255;5946.583739138218;5896.469317761336;5906.704664766745;5907.852303692442;5916.408359164049;5936.7922122725495;4546.02260513991;4553.248713962225;4555.498895121534;4567.406237189144;4599.33309670096;3966.6231707987695;3971.821268042945;4046.2918989177365;4055.5538890721996;4112.177564487115;5618.775248989995;5649.971750141223;5663.9716801415725;5671.631343962629;5687;5930.584859059824;5948.137520059568;5950.7917222896995;5968.403159683997;5982.73077711504;5406.08096623575;5500.642458240201;5563.554915606823;5636.689982051026;5735.598508104476;5165.612579056586;5198.610104242197;5212.348456442945;5212.713300768418;5224;6102.816915492543;6125.264968203844;6139.570230083851;6141.570090093651;6154.415330543591;5759.971200143972;5819.6508209507565;5929.851753706192;5935.4064593542025;5945.078512830518;6102.658667634139;6120.6299886969155;6139.815805525842;6144.907826382697;6153.600015998945;5800.158976948234;5851.034579294369;5855.268091488564;5881.264841894763;5890.410958904075;5763.221965034834;5782.508486778671;5895.764169433174;5946.07835785454;5958.702064896825;5705.7147142643535;5712.885742285048;5718.485336319751;5724.398938111605;5728.054870946247;5675;5708.6574805510145;5729.512991395778;5730.5702072345575;5757.625754325955;5473.562115030868;5529.336479622471;5621.072523033654;5628.437156284339;5748.712564371848;5778.306603207642;5793.188953546591;5798.391168927202;5808.39011903744;5826.76692932278;5640.351359593699;5676.290463692038;5713.742881570256;5716.828495145152;5718.628289161191 21:13:54 INFO - 2015-11-25 21:13:54,327 DEBUG : BROWSER_OUTPUT: |1;ext.html;532.1830989431223;561.8146011816101;569.5585920911293;572.4447286132452;606.0908637044433;31750.841245793767;41530;42034.7898260509;42238.366424503656;42408;44639;44997;45202.32196517055;45207;45291.77354113225;8658.350623703216;8843.469391836477;8853.070427605106;8891.911080889173;8954.910450895473;8679.826403471958;8825.779355516132;8829.735107946772;8830;8836.513991730451;8844.867326990101;8945.64217431302;8982.101789820998;8990.011098779129;8995.145461181177;8767.167119123706;8839.204471597555;8862.778430539223;8902.86645700315;8918.152775486318;8778;8872.423292485968;8877.245434138105;8892.555372231363;8908.287337013024;41184.38223426651;41563.376549351786;41642.167156657;41868;41997.37003944943;3258.7881787683964;3344.0803778960735;3586.55168103987;3689.760165589228;4040.7575545467366;30560;30687.386252275053;31441.37117257642;31563.684363156535;32352.352952940808;3800.1639639279592;3808.257389808961;3830.636089571486;3852.171783066626;3916.0797212655;272891;273097;273562.63218683976;274270;274897;54493.45506544884;55427;60258.78188526849;60755;68513;65754.67122664451;65845.34154658488;65917.67041164859;66045.33954660488;66113.33886661168;15943.840561594468;15969;16065.357385704441;16130.435434759727;16156.838431615533;12310.569130080405;12315.568955086528;12349.876501235052;12392.442340094718;12424.937875310565;20976.685349719766;21092.578148437253;21199;21207;21230.36308910735;7795.844083118419;7981.64082616272;7990.2893707572475;8059.758207253792;8082.919170808216;940.6378544260372;976.1263669016191;1010.2019404670375;1029.3772267777886;1100.1418893263267;28842.134735957956;29198.416031679673;29564;29799.40401191964;29924.850375748418;1003.0370843989851;1033.6382266206917;1073.5974009746344;1088.8257878739523;1102.8841971593029;13894.374753136133;14225.64435889111;15881.444149454945;16164.110973896548;16616.418425355056;325584;325874;327197;328619;329858;54499;54524.18213726797;54670.453295467334;54708.452915471134;55057;1328.8073229381685;1362.3120324236197;1364.8566900475505;1366.4875671623142;1370.0683535195963;29386.11841644754;29509.704902951555;30460.84769576138;31515.21211969719;31721.682783171873;51003;51258.74370628123;51480.74259628678;51649.741751291;51814;285217;287683;287814;288000;288024;32185.678143219204;32971.51628176786;33232;33280.833595831864;33304.1673958153;39877.601223988546;40438.393424098074;40460.1907961845;40514.1897162061;40826;34082.82958585191;34231.144221394665;34775.826120870246;38064;38677.6132238674;33610.327793444485;33908.66091339055;33997.980060598224;34501.654983449844;34541.48187777135;34154.14614634654;37013;37149.25701486009;37506;37565.43651845279;28832.279193020342;30789.23026924345;31773.523397148598;31804.68195318017;31844.68155318417;24061.879690601436;24128.155514556907;24211.878940605184;24478.265652030466;24548.877255613606 21:13:54 INFO - 2015-11-25 21:13:54,330 DEBUG : BROWSER_OUTPUT: |2;jquery.html;324.94800831866894;349.4129861832121;350.831600831601;353.6163262859797;356.7787971457696;16713.665726685475;17046.74429883551;17764.822351776478;18169.273229070855;18738.344157954474;9633.08485693858;9638.951805240982;9641.758956026102;10211.591536338556;10429.634962776305;4969.527894849984;4988.526090021452;5119.974400127994;5141.5886729061585;5152.665076770017;5028.874278143039;5068.74656267187;5072;5073.873153171182;5075.796968121271;5029.597632189416;5058.392992840864;5067.670601410915;5070.569001634865;5199.14214154664;5102.795888164469;5146.459621739719;5156.381234251876;5160.2517634942915;5161.458046905077;4810.06203790261;4853.39332583427;4862.17343051682;4864.756762161913;4887.853364399074;12612.243265404106;12803.679908002374;15643.687126257524;21360;21392.25127120559;2026.3414390323057;2107.2729908181655;2164.9134034638596;2188.3325585696357;2217.135317226283;9675.274354423376;9883.802323953552;10084.042016008467;10905.618303359424;13701.931490342584;1896.3931541906595;1910.4841692742882;1914.3969649560345;1916.645420597194;1923.413358925527;61187.69406152941;62644.686776565824;64356.67821660862;64374;65535.672321638085;9810.558524866397;10102.595896164217;10272.126869216201;10297.433641149659;10339.586416543254;13401.932990334986;13443.932780336036;13462.86537134616;13463.192208467523;13471.92224622028;7750.7674769756995;7750.922490775133;7772.145064042951;7827.921720782833;7837.568933708701;7561.7731468056045;7586.468947173756;7591.3547348475995;7643.235676432312;7700.075990881131;4378.255696531597;4390;4403.9559604404185;4414.161309351213;4418.2047231498;1638.2382192280647;1657.4364715996378;1664.0265444714735;1672.5316911264865;1681.201429321087;414.3246508191689;422.81818817908595;427.05833636831335;432.08182611949604;465.0698602794411;10559.260851740459;16487.752683709754;17022;17103.14484275781;17445.302187912595;886.4415418286567;913.0823522359985;937.9859302110474;956.2445667922402;1015.9325772053983;9451.243900488082;9466.337356384987;9617.23062155026;9634.277429192838;9682.225421966226;548901;557253;559525;573869;578906;79420;80905.59547202344;82447.17552824515;82851;84995.5750221245;1133.9659810205708;1142.891365430779;1147.6786499780076;1164.8078067118831;1174.7004513848915;14849.92575037118;15502.612434689223;15582.688346233239;15608.205056418657;15632.06207627546;32817.67182328146;33077.50383744294;33226;33949.66050339564;34443.13892152716;45540.07978962714;45764;48091.75954120347;49400.50599493959;50887.2366914504;9084.364094513585;9486.857697134687;9537.380070295409;9608.183304418922;9647.855282170913;11169.72075698114;14521.419143234574;16973.23620437108;17203.827961720723;17458.47624571214;13680.863191367958;14367.066140700821;14387.712245755236;14468.493602723855;14946.476873309817;14134.363953621905;14143.363548640542;14467;14474.927625361806;14729;14867.776983345475;15100.848991509944;15281.541553753405;15587.142707151215;15622.609434764221;9351.345405821527;9359.391639543408;9435.858462122937;9547.76130596713;9567.9043209567;9982.338325832816;14729.55811325662;14878.776818347516;14973.176475293963;15070.095794251942 21:13:54 INFO - 2015-11-25 21:13:54,330 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1474.0787008119926;1513.8259100203472;1575.5588435238137;1652.1161178769353;1752;7299.927000729991;7460.813479663011;7556.093268807744;7655.846883062335;7698.268664476873;7693.615319234043;7748.341390981774;7749.457537972344;7811.531308121516;7823;2195.2536137713137;2205.492736670567;2219.2343641443676;2222.744384395791;2223.6998005269324;2277.7266727992583;2312.1213938703354;2312.7455979842202;2315.455867871049;2317.6639387288833;2127.8723276603378;2180.1933284684687;2200.471886747177;2268.5349503351854;2293.5986202414592;2257.887105644711;2258.920937767187;2284.6344584866424;2298.7931086202157;2303.5968705476557;2325.9069637214493;2335.859848409101;2350.74141844397;2355.1639168095253;2358.2099996501192;7519.097708274987;7592.164861865191;7598.392128629696;7607.923920760777;7620.428467864932;4693.366395536593;4747.52524747526;4782.13921494131;4782.258749893737;4800.231962885921;3033.1810411189076;3053.1451193665807;3079.16862447138;3105.7825952183357;3121.672224416426;1034.6068493972243;1035.0425856083093;1062.2564205056492;1118.9496472658668;1878.2205384765307;10060.748481287954;10129.848052279222;10132.645357412455;10145.44200068996;10158.695239142764;4239.894002649897;4266.530681625019;4400.559944005574;4428.756418396954;4452.0428107956295;8778.780530486789;8834.116588341114;8845.778855528662;8854.513001784835;8878.955605221932;4751.287306903992;4818.10864989978;4822.565969062801;4841.830535931225;4856.490068542752;4379.890502737393;4380.14587155508;4384.868453946387;4396.472423309159;4420.447444069491;3581.982090089585;3662.7252956028406;3684.9447258291148;3691.0956815579816;3709.925801483955;1192.3501691577937;1198.1373411143963;1204.5302332090491;1212.0485418946262;1219.0674134287278;976.6142373762324;1030.006044167382;1146.9677290438506;1234.4383305595932;1374.0793668242302;6938.306169383021;7104.964475177694;7119.696242135022;7160.212376638566;7167.139943206848;587.7737071227608;602.2592211579781;608.9786857459968;609.439315829438;765.7938746474325;5379.381371142291;5434.130539113723;5445.59158063139;5469.124940009579;5474.042042642522;8866.290696744245;8960.820783584291;9154.542272886461;9283.72148835536;9337.253019758538;9080;9124.680636177702;9168.26653867689;9170.633174673072;9250.814983700287;6956.686949087303;7123.501354905211;7187.38907192884;7199.460040496983;7271.963640181871;7185.928140718526;7199.3520583147765;7216.170140433707;7248.166460857069;7260.237675044044;8028.197180281925;8229.46508476947;8291.62687679068;8291.668333266602;8316.584170791557;8340.124286949784;8397.874031889649;8409.87385189235;8416.452930559493;8450.704225352083;6488.805335839932;6551.050097735897;6622.4702023838945;6725.831854203489;6768.390844823793;7073.115860517435;7100.183478899992;7123.536970096927;7129.536580122275;7129.750458734127;6575.210974683068;6579.671016449062;6732.899006515004;6766.661666916536;6855.554388964901;6681.265060843206;6699.095622090956;6738.326167383222;6830.180378354629;6849.2808255132495;6638.269790322964;6767.966160169168;6782.084418603426;6782.423494003065;6799.6600169990315;6198.504119670325;6201.627902325875;6218.471429928507;6240.313565507699;6241.625502469867;6304.527160463075;6350.460210882126;6394.040893865771;6414;6435.613863168225 21:13:54 INFO - 2015-11-25 21:13:54,330 DEBUG : BROWSER_OUTPUT: |4;prototype.html;307.1231633685827;333.0890015806768;339.7180340317537;343.54308769336785;345.22496994247916;6306.117143599894;6311.274203466603;6361.332060133689;6372.267189273235;6431.292557818636;6119.877602447948;6267.4672652824565;6287.245530536331;6291.653959032252;6293.748250069992;4796.664233503656;4809.134355815969;4814.54261845125;4815.470298267188;4821.590164835993;4816.422029356482;4819.831305904294;4827.420709514863;4833.879153021167;4838.225883858583;4685.976570117145;4767.523247675222;4780.259059845712;4786.066716990188;4787.521247875202;4777.641676874231;4779.976100119512;4783;4787.066522028206;4793.784279707422;4118.670506359514;4121.175764847043;4127.195196936568;4130.772807495587;4137.50349958004;5966.194563733884;5982.46157845796;5989.670568118751;5991.221141251609;6000.6399616022745;5418.7019713915715;5535.308086489189;5536.833894983117;5548.445155484419;5552.888942221173;6644.634545100018;6657.1345725055435;6666.899996500057;6675.46596272297;6691.6319602421845;4576.222042252825;4584.770761461914;4596.080783843211;4601.585857272828;4607.470140933769;6770.255271920085;6881.208661003949;6933.445324374038;6951.617661028641;6952.2352541220935;4606.907861842745;4611.962308480565;4621.722696638212;4632.745199014086;4648.628109751212;4703.811847526129;4716.6698331116495;4720.45714742809;4721.3390125382475;4721.551452611996;5481.479259470424;5494.066008778517;5496.780128794803;5500.917486237709;5508.779648814083;6512.967435162794;6564.8358791030605;6575.145231119924;6628.4697224221945;6637.668116594247;1632.7877375941289;1654.8676105911497;1660.0703605980689;1672.9498115056567;1674.5646132005766;1090.6564432203832;1097.5061222449929;1098.0666433531435;1101.2566517600749;1112.1825458288151;6292.552712876064;6305.180326557518;6310.0850376695125;6355.968220158869;6378.649174295459;6814.829629259309;6826.4538836892925;6826.829329266808;6829.385355318045;6835.7949261522235;6202.317745048041;6299.488122850575;6360.459360954278;6376.713047912763;6378.532937424418;3701.0377301901162;3726.124360775216;3738.0841693785196;3741.9251614967548;3749.1002159481527;7068.787936361918;7069.081019467436;7072.7524536642;7096.680649370791;7117.288271172842;6901.447884169254;6986.476014298846;6997.300269973064;7002.40479559233;7018.473614478935;7258.673359698826;7262.201157872735;7267.091613548307;7272.381847543018;7300.342969132804;6963.9303606963285;6972.337627925339;6975.860482790417;6976.534927665247;6977.372036516738;6776.593404395752;6789.083473730983;6823.795286141423;6885;6933.861322773415;7243.0946131733535;7250.818729531804;7251.709931602677;7262.128544574685;7264;4672.57946784791;4711.693739906895;4722.1028004679;4725.480197178239;4731.526847315241;6785.89821152693;6927.203371612329;6956.165260168812;6961.7215311389;6991.405730512964;6751.324867513209;6797.93202067973;6802.93197068023;6807.0810440589885;6818.147731533559;6747.359000894907;6781.457483401217;6790.25307216196;6794.422474089758;6798.8640227196165;6528.347165283433;6592.538522303585;6627.768028118992;6633.535652504278;6635.568688035262;6784.864302714017;6795.456363491007;6797.9945915955905;6808.080909077211;6819.488538359544;6554.63949482783;6559.147310849559;6573.211214654272;6579.736810527525;6583.0454584086 21:13:54 INFO - 2015-11-25 21:13:54,332 DEBUG : BROWSER_OUTPUT: |5;yui.html;743.6876511865016;771.8533478639058;792.1484404265416;847.7753395350229;849.7026040885695;13812.240326782035;14287.142771433708;14290.928545357285;14318.355673994656;14373.065750726195;13188;13347.733045339111;13382.799258011113;13422.463101475954;13438.395272212749;829.5769157729571;846.3905987688885;849.1678155407704;853.4580541356253;858.8883445152153;843.9789005274887;848.817504236589;849.8555245608261;850.4812064640564;851.4891065360796;883.2757139145903;892.5849479991803;895.042304733935;896.2471523919907;897.7172190759923;874.3704532736483;881.1672969044256;886.7561420609352;887.742554659148;891.7280229529958;658.0688326018678;661.2032500836481;663.1611012069735;664.830468230603;664.9900251496232;13584.388702508411;13798.379072941741;13821.861781382258;13859.099158554662;13862.93068534661;12137.757244855142;12186.268823870596;12312.569060082855;12738.745225095447;12756.872431275755;10200.846987295197;10318;10362.689119326433;10542.36745795247;10611.84082238767;3564.0733409313766;3622.963770362289;3627;3652.3243200008083;3702.666759991587;51607;51647.483525164644;51696.48303516954;51785.482145178445;51894;10052.145567626834;10424.113950314157;10482.161427085815;10485.685429436977;10706.78586428267;17822.5544361392;17852.19665115073;17852.821471785115;17857.642847142983;17912.731309030376;7227.602481863443;7275.490715649854;7763.92236077632;7797.064352277763;7803.492772969739;4193.496780386312;4282.314829627245;4369.191699535596;4381.3208952612395;4383.320585309282;3066.7853250272715;3075.400296942075;3086.830224337683;3104.4101620691995;3105.3013072058607;542.6472792684708;545.939946605873;555.8138023762004;561.0658254007033;564.7261078377066;608.8264844519291;639.4596565901805;652.2531701202192;653.8823011857911;705.9647017649097;7913.683452661944;8010.439269251096;8043.994500687414;8066.798330041796;8312;553.5543887170866;630.2468550082607;675.2336098528108;683.2723149845399;688.2994052895062;3791.336516109725;3801.4487899255005;3852.9807350963624;3908.7459315144424;3914.569397366344;52827.73586132045;63823;63934;63971.36028639654;64286.67856660687;49147.43532181927;49913;50101.24848127281;50565.49434505682;50856.23715644268;48975;49364.25953610627;49414;50047.74976125096;50430;8334.791630209293;8474.1949514796;8740.475571465733;8856.202941735275;8930.330225233003;34760.82619586886;35525.28949420946;35565.46651800173;35618.821905890305;35943.28113437769;49286;49343.506564933894;49972.50192486491;49994.500054998985;50172.498275018246;10314.43270620123;10977.945110274717;11031.338119712844;11035.889641103808;11396.658100257006;11755.941220293844;11947.820782688093;11996.280223186637;12133.817992729939;12640.241585504898;11266.098712103176;11296.152788541056;11358.432078395881;11509.597164099216;11936.343501107522;11065.834012489659;11269.549218031187;11315.603953861575;11689.473973671034;11706.063514918616;11394.37330946806;11513.424328783694;11874.465649045986;11926.463309150935;11956.940215298868;9598.85601715961;9679.951600241953;9898.257630677872;10236.232282578985;10365.429901355195;8670.257641637822;8928.821423571622;9202.815943680955;9740.172085372822;9883.555240014073 21:13:54 INFO - 2015-11-25 21:13:54,332 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:13:54 INFO - 2015-11-25 21:13:54,332 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:13:54 INFO - 2015-11-25 21:13:54,332 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,307 21:13:54 INFO - 2015-11-25 21:13:54,332 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:13:54 INFO - 2015-11-25 21:13:54,332 DEBUG : BROWSER_OUTPUT: __startTimestamp1448514834323__endTimestamp 21:13:54 INFO - 2015-11-25 21:13:54,332 DEBUG : BROWSER_OUTPUT: 21:13:54 INFO - 2015-11-25 21:13:54,332 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:13:54 INFO - 2015-11-25 21:13:54,333 DEBUG : BROWSER_OUTPUT: Number of tests: 6 21:13:54 INFO - 2015-11-25 21:13:54,333 DEBUG : BROWSER_OUTPUT: 21:13:54 INFO - 2015-11-25 21:13:54,333 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5465.39 Median:5705.71 stddev:614.49 (10.8%) stddev-sans-first:590.71 21:13:54 INFO - 2015-11-25 21:13:54,333 DEBUG : BROWSER_OUTPUT: Values: 3225.2 3281.8 3294.1 3322.5 3340.1 5256.1 5409.0 5438.9 5462.5 5476.6 5340.8 5387.4 5420.5 5421.5 5439.3 4682.7 4976.5 5025.1 5040.7 5082.7 4848.2 5000.9 5008.7 5050.6 5063.8 4760.8 4931.5 4945.0 4969.1 4971.3 4987.5 5033.7 5048.0 5063.6 5086.3 4784.2 4870.8 4984.7 4994.8 5092.2 4997.6 5219.2 5241.6 5309.2 5385.9 5903.4 5910.1 5921.0 5933.2 5936.0 5726.6 5865.7 5866.5 5950.3 5994.2 5450.7 5468.3 5504.6 5505.6 5508.1 5877.0 5885.3 5940.3 5942.0 5954.9 5866.6 5873.4 5881.4 5893.0 5920.4 5860.1 5922.2 5960.0 5962.8 5974.3 5672.6 5817.4 5825.2 5927.9 5946.6 5896.5 5906.7 5907.9 5916.4 5936.8 4546.0 4553.2 4555.5 4567.4 4599.3 3966.6 3971.8 4046.3 4055.6 4112.2 5618.8 5650.0 5664.0 5671.6 5687.0 5930.6 5948.1 5950.8 5968.4 5982.7 5406.1 5500.6 5563.6 5636.7 5735.6 5165.6 5198.6 5212.3 5212.7 5224.0 6102.8 6125.3 6139.6 6141.6 6154.4 5760.0 5819.7 5929.9 5935.4 5945.1 6102.7 6120.6 6139.8 6144.9 6153.6 5800.2 5851.0 5855.3 5881.3 5890.4 5763.2 5782.5 5895.8 5946.1 5958.7 5705.7 5712.9 5718.5 5724.4 5728.1 5675.0 5708.7 5729.5 5730.6 5757.6 5473.6 5529.3 5621.1 5628.4 5748.7 5778.3 5793.2 5798.4 5808.4 5826.8 5640.4 5676.3 5713.7 5716.8 5718.6 21:13:54 INFO - 2015-11-25 21:13:54,333 DEBUG : BROWSER_OUTPUT: 21:13:54 INFO - 2015-11-25 21:13:54,333 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47294.22 Median:3638.16 stddev:77607.71 (2133.2%) stddev-sans-first:77746.00 21:13:54 INFO - 2015-11-25 21:13:54,335 DEBUG : BROWSER_OUTPUT: Values: 532.2 561.8 569.6 572.4 606.1 31750.8 41530.0 42034.8 42238.4 42408.0 44639.0 44997.0 45202.3 45207.0 45291.8 8658.4 8843.5 8853.1 8891.9 8954.9 8679.8 8825.8 8829.7 8830.0 8836.5 8844.9 8945.6 8982.1 8990.0 8995.1 8767.2 8839.2 8862.8 8902.9 8918.2 8778.0 8872.4 8877.2 8892.6 8908.3 41184.4 41563.4 41642.2 41868.0 41997.4 3258.8 3344.1 3586.6 3689.8 4040.8 30560.0 30687.4 31441.4 31563.7 32352.4 3800.2 3808.3 3830.6 3852.2 3916.1 272891.0 273097.0 273562.6 274270.0 274897.0 54493.5 55427.0 60258.8 60755.0 68513.0 65754.7 65845.3 65917.7 66045.3 66113.3 15943.8 15969.0 16065.4 16130.4 16156.8 12310.6 12315.6 12349.9 12392.4 12424.9 20976.7 21092.6 21199.0 21207.0 21230.4 7795.8 7981.6 7990.3 8059.8 8082.9 940.6 976.1 1010.2 1029.4 1100.1 28842.1 29198.4 29564.0 29799.4 29924.9 1003.0 1033.6 1073.6 1088.8 1102.9 13894.4 14225.6 15881.4 16164.1 16616.4 325584.0 325874.0 327197.0 328619.0 329858.0 54499.0 54524.2 54670.5 54708.5 55057.0 1328.8 1362.3 1364.9 1366.5 1370.1 29386.1 29509.7 30460.8 31515.2 31721.7 51003.0 51258.7 51480.7 51649.7 51814.0 285217.0 287683.0 287814.0 288000.0 288024.0 32185.7 32971.5 33232.0 33280.8 33304.2 39877.6 40438.4 40460.2 40514.2 40826.0 34082.8 34231.1 34775.8 38064.0 38677.6 33610.3 33908.7 33998.0 34501.7 34541.5 34154.1 37013.0 37149.3 37506.0 37565.4 28832.3 30789.2 31773.5 31804.7 31844.7 24061.9 24128.2 24211.9 24478.3 24548.9 21:13:54 INFO - 2015-11-25 21:13:54,335 DEBUG : BROWSER_OUTPUT: 21:13:54 INFO - 2015-11-25 21:13:54,335 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29344.87 Median:424.94 stddev:92201.01 (21697.5%) stddev-sans-first:92433.90 21:13:54 INFO - 2015-11-25 21:13:54,336 DEBUG : BROWSER_OUTPUT: Values: 324.9 349.4 350.8 353.6 356.8 16713.7 17046.7 17764.8 18169.3 18738.3 9633.1 9639.0 9641.8 10211.6 10429.6 4969.5 4988.5 5120.0 5141.6 5152.7 5028.9 5068.7 5072.0 5073.9 5075.8 5029.6 5058.4 5067.7 5070.6 5199.1 5102.8 5146.5 5156.4 5160.3 5161.5 4810.1 4853.4 4862.2 4864.8 4887.9 12612.2 12803.7 15643.7 21360.0 21392.3 2026.3 2107.3 2164.9 2188.3 2217.1 9675.3 9883.8 10084.0 10905.6 13701.9 1896.4 1910.5 1914.4 1916.6 1923.4 61187.7 62644.7 64356.7 64374.0 65535.7 9810.6 10102.6 10272.1 10297.4 10339.6 13401.9 13443.9 13462.9 13463.2 13471.9 7750.8 7750.9 7772.1 7827.9 7837.6 7561.8 7586.5 7591.4 7643.2 7700.1 4378.3 4390.0 4404.0 4414.2 4418.2 1638.2 1657.4 1664.0 1672.5 1681.2 414.3 422.8 427.1 432.1 465.1 10559.3 16487.8 17022.0 17103.1 17445.3 886.4 913.1 938.0 956.2 1015.9 9451.2 9466.3 9617.2 9634.3 9682.2 548901.0 557253.0 559525.0 573869.0 578906.0 79420.0 80905.6 82447.2 82851.0 84995.6 1134.0 1142.9 1147.7 1164.8 1174.7 14849.9 15502.6 15582.7 15608.2 15632.1 32817.7 33077.5 33226.0 33949.7 34443.1 45540.1 45764.0 48091.8 49400.5 50887.2 9084.4 9486.9 9537.4 9608.2 9647.9 11169.7 14521.4 16973.2 17203.8 17458.5 13680.9 14367.1 14387.7 14468.5 14946.5 14134.4 14143.4 14467.0 14474.9 14729.0 14867.8 15100.8 15281.5 15587.1 15622.6 9351.3 9359.4 9435.9 9547.8 9567.9 9982.3 14729.6 14878.8 14973.2 15070.1 21:13:54 INFO - 2015-11-25 21:13:54,336 DEBUG : BROWSER_OUTPUT: 21:13:54 INFO - 2015-11-25 21:13:54,337 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5346.59 Median:6229.39 stddev:2722.90 (43.7%) stddev-sans-first:2714.99 21:13:54 INFO - 2015-11-25 21:13:54,337 DEBUG : BROWSER_OUTPUT: Values: 1474.1 1513.8 1575.6 1652.1 1752.0 7299.9 7460.8 7556.1 7655.8 7698.3 7693.6 7748.3 7749.5 7811.5 7823.0 2195.3 2205.5 2219.2 2222.7 2223.7 2277.7 2312.1 2312.7 2315.5 2317.7 2127.9 2180.2 2200.5 2268.5 2293.6 2257.9 2258.9 2284.6 2298.8 2303.6 2325.9 2335.9 2350.7 2355.2 2358.2 7519.1 7592.2 7598.4 7607.9 7620.4 4693.4 4747.5 4782.1 4782.3 4800.2 3033.2 3053.1 3079.2 3105.8 3121.7 1034.6 1035.0 1062.3 1118.9 1878.2 10060.7 10129.8 10132.6 10145.4 10158.7 4239.9 4266.5 4400.6 4428.8 4452.0 8778.8 8834.1 8845.8 8854.5 8879.0 4751.3 4818.1 4822.6 4841.8 4856.5 4379.9 4380.1 4384.9 4396.5 4420.4 3582.0 3662.7 3684.9 3691.1 3709.9 1192.4 1198.1 1204.5 1212.0 1219.1 976.6 1030.0 1147.0 1234.4 1374.1 6938.3 7105.0 7119.7 7160.2 7167.1 587.8 602.3 609.0 609.4 765.8 5379.4 5434.1 5445.6 5469.1 5474.0 8866.3 8960.8 9154.5 9283.7 9337.3 9080.0 9124.7 9168.3 9170.6 9250.8 6956.7 7123.5 7187.4 7199.5 7272.0 7185.9 7199.4 7216.2 7248.2 7260.2 8028.2 8229.5 8291.6 8291.7 8316.6 8340.1 8397.9 8409.9 8416.5 8450.7 6488.8 6551.1 6622.5 6725.8 6768.4 7073.1 7100.2 7123.5 7129.5 7129.8 6575.2 6579.7 6732.9 6766.7 6855.6 6681.3 6699.1 6738.3 6830.2 6849.3 6638.3 6768.0 6782.1 6782.4 6799.7 6198.5 6201.6 6218.5 6240.3 6241.6 6304.5 6350.5 6394.0 6414.0 6435.6 21:13:54 INFO - 2015-11-25 21:13:54,337 DEBUG : BROWSER_OUTPUT: 21:13:54 INFO - 2015-11-25 21:13:54,337 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5580.66 Median:6310.68 stddev:1703.45 (27.0%) stddev-sans-first:1661.60 21:13:54 INFO - 2015-11-25 21:13:54,338 DEBUG : BROWSER_OUTPUT: Values: 307.1 333.1 339.7 343.5 345.2 6306.1 6311.3 6361.3 6372.3 6431.3 6119.9 6267.5 6287.2 6291.7 6293.7 4796.7 4809.1 4814.5 4815.5 4821.6 4816.4 4819.8 4827.4 4833.9 4838.2 4686.0 4767.5 4780.3 4786.1 4787.5 4777.6 4780.0 4783.0 4787.1 4793.8 4118.7 4121.2 4127.2 4130.8 4137.5 5966.2 5982.5 5989.7 5991.2 6000.6 5418.7 5535.3 5536.8 5548.4 5552.9 6644.6 6657.1 6666.9 6675.5 6691.6 4576.2 4584.8 4596.1 4601.6 4607.5 6770.3 6881.2 6933.4 6951.6 6952.2 4606.9 4612.0 4621.7 4632.7 4648.6 4703.8 4716.7 4720.5 4721.3 4721.6 5481.5 5494.1 5496.8 5500.9 5508.8 6513.0 6564.8 6575.1 6628.5 6637.7 1632.8 1654.9 1660.1 1672.9 1674.6 1090.7 1097.5 1098.1 1101.3 1112.2 6292.6 6305.2 6310.1 6356.0 6378.6 6814.8 6826.5 6826.8 6829.4 6835.8 6202.3 6299.5 6360.5 6376.7 6378.5 3701.0 3726.1 3738.1 3741.9 3749.1 7068.8 7069.1 7072.8 7096.7 7117.3 6901.4 6986.5 6997.3 7002.4 7018.5 7258.7 7262.2 7267.1 7272.4 7300.3 6963.9 6972.3 6975.9 6976.5 6977.4 6776.6 6789.1 6823.8 6885.0 6933.9 7243.1 7250.8 7251.7 7262.1 7264.0 4672.6 4711.7 4722.1 4725.5 4731.5 6785.9 6927.2 6956.2 6961.7 6991.4 6751.3 6797.9 6802.9 6807.1 6818.1 6747.4 6781.5 6790.3 6794.4 6798.9 6528.3 6592.5 6627.8 6633.5 6635.6 6784.9 6795.5 6798.0 6808.1 6819.5 6554.6 6559.1 6573.2 6579.7 6583.0 21:13:54 INFO - 2015-11-25 21:13:54,338 DEBUG : BROWSER_OUTPUT: 21:13:54 INFO - 2015-11-25 21:13:54,338 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14274.29 Median:49353.88 stddev:16928.82 (34.3%) stddev-sans-first:16945.82 21:13:54 INFO - 2015-11-25 21:13:54,339 DEBUG : BROWSER_OUTPUT: Values: 743.7 771.9 792.1 847.8 849.7 13812.2 14287.1 14290.9 14318.4 14373.1 13188.0 13347.7 13382.8 13422.5 13438.4 829.6 846.4 849.2 853.5 858.9 844.0 848.8 849.9 850.5 851.5 883.3 892.6 895.0 896.2 897.7 874.4 881.2 886.8 887.7 891.7 658.1 661.2 663.2 664.8 665.0 13584.4 13798.4 13821.9 13859.1 13862.9 12137.8 12186.3 12312.6 12738.7 12756.9 10200.8 10318.0 10362.7 10542.4 10611.8 3564.1 3623.0 3627.0 3652.3 3702.7 51607.0 51647.5 51696.5 51785.5 51894.0 10052.1 10424.1 10482.2 10485.7 10706.8 17822.6 17852.2 17852.8 17857.6 17912.7 7227.6 7275.5 7763.9 7797.1 7803.5 4193.5 4282.3 4369.2 4381.3 4383.3 3066.8 3075.4 3086.8 3104.4 3105.3 542.6 545.9 555.8 561.1 564.7 608.8 639.5 652.3 653.9 706.0 7913.7 8010.4 8044.0 8066.8 8312.0 553.6 630.2 675.2 683.3 688.3 3791.3 3801.4 3853.0 3908.7 3914.6 52827.7 63823.0 63934.0 63971.4 64286.7 49147.4 49913.0 50101.2 50565.5 50856.2 48975.0 49364.3 49414.0 50047.7 50430.0 8334.8 8474.2 8740.5 8856.2 8930.3 34760.8 35525.3 35565.5 35618.8 35943.3 49286.0 49343.5 49972.5 49994.5 50172.5 10314.4 10977.9 11031.3 11035.9 11396.7 11755.9 11947.8 11996.3 12133.8 12640.2 11266.1 11296.2 11358.4 11509.6 11936.3 11065.8 11269.5 11315.6 11689.5 11706.1 11394.4 11513.4 11874.5 11926.5 11956.9 9598.9 9680.0 9898.3 10236.2 10365.4 8670.3 8928.8 9202.8 9740.2 9883.6 21:13:54 INFO - 2015-11-25 21:13:54,340 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:13:54 INFO - 2015-11-25 21:13:54,340 DEBUG : BROWSER_OUTPUT: 21:13:54 INFO - 2015-11-25 21:13:54,961 INFO : Browser exited with error code: 0 21:13:54 INFO - 2015-11-25 21:13:54,983 INFO : Completed test dromaeo_css (00:18:30) 21:13:54 INFO - 2015-11-25 21:13:54,983 INFO : Starting test kraken 21:13:54 INFO - 2015-11-25 21:13:54,983 DEBUG : operating with platform_type : linux_ 21:13:54 INFO - 2015-11-25 21:13:54,983 INFO : Initialising browser for kraken test... 21:13:54 INFO - 2015-11-25 21:13:54,989 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAs8_Fx/profile http://localhost:40704/getInfo.html 21:13:59 INFO - 2015-11-25 21:13:59,258 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:13:59 INFO - 2015-11-25 21:13:59,258 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:13:59 INFO - 2015-11-25 21:13:59,258 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:13:59 INFO - 2015-11-25 21:13:59,258 DEBUG : BROWSER_OUTPUT: __metrics 21:14:00 INFO - 2015-11-25 21:14:00,237 INFO : Browser initialized. 21:14:00 INFO - 2015-11-25 21:14:00,238 INFO : Running cycle 1/1 for kraken test... 21:14:00 INFO - 2015-11-25 21:14:00,238 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAs8_Fx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:14:12 INFO - 2015-11-25 21:14:12,098 DEBUG : BROWSER_OUTPUT: RSS: Main: 139194368 21:14:12 INFO - 2015-11-25 21:14:12,098 DEBUG : BROWSER_OUTPUT: 21:14:14 INFO - 2015-11-25 21:14:14,599 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40704/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40704/tests/kraken/driver.html?testName=audio-beat-detection) 21:14:15 INFO - 2015-11-25 21:14:15,205 DEBUG : BROWSER_OUTPUT: RSS: Main: 141479936 21:14:15 INFO - 2015-11-25 21:14:15,205 DEBUG : BROWSER_OUTPUT: 21:14:17 INFO - 2015-11-25 21:14:17,863 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40704/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40704/tests/kraken/driver.html?testName=audio-dft) 21:14:18 INFO - 2015-11-25 21:14:18,446 DEBUG : BROWSER_OUTPUT: RSS: Main: 141713408 21:14:18 INFO - 2015-11-25 21:14:18,446 DEBUG : BROWSER_OUTPUT: 21:14:21 INFO - 2015-11-25 21:14:21,276 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40704/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40704/tests/kraken/driver.html?testName=audio-fft) 21:14:21 INFO - 2015-11-25 21:14:21,859 DEBUG : BROWSER_OUTPUT: RSS: Main: 136548352 21:14:21 INFO - 2015-11-25 21:14:21,859 DEBUG : BROWSER_OUTPUT: 21:14:23 INFO - 2015-11-25 21:14:23,831 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40704/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40704/tests/kraken/driver.html?testName=audio-oscillator) 21:14:24 INFO - 2015-11-25 21:14:24,445 DEBUG : BROWSER_OUTPUT: RSS: Main: 136826880 21:14:24 INFO - 2015-11-25 21:14:24,445 DEBUG : BROWSER_OUTPUT: 21:14:26 INFO - 2015-11-25 21:14:26,658 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40704/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40704/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:14:27 INFO - 2015-11-25 21:14:27,239 DEBUG : BROWSER_OUTPUT: RSS: Main: 138104832 21:14:27 INFO - 2015-11-25 21:14:27,240 DEBUG : BROWSER_OUTPUT: 21:14:30 INFO - 2015-11-25 21:14:30,243 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40704/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40704/tests/kraken/driver.html?testName=imaging-darkroom) 21:14:30 INFO - 2015-11-25 21:14:30,829 DEBUG : BROWSER_OUTPUT: RSS: Main: 137678848 21:14:30 INFO - 2015-11-25 21:14:30,829 DEBUG : BROWSER_OUTPUT: 21:14:34 INFO - 2015-11-25 21:14:34,195 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40704/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40704/tests/kraken/driver.html?testName=imaging-desaturate) 21:14:34 INFO - 2015-11-25 21:14:34,796 DEBUG : BROWSER_OUTPUT: RSS: Main: 137969664 21:14:34 INFO - 2015-11-25 21:14:34,796 DEBUG : BROWSER_OUTPUT: 21:14:37 INFO - 2015-11-25 21:14:37,616 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40704/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40704/tests/kraken/driver.html?testName=json-parse-financial) 21:14:38 INFO - 2015-11-25 21:14:38,203 DEBUG : BROWSER_OUTPUT: RSS: Main: 138502144 21:14:38 INFO - 2015-11-25 21:14:38,203 DEBUG : BROWSER_OUTPUT: 21:14:39 INFO - 2015-11-25 21:14:39,791 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40704/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40704/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:14:40 INFO - 2015-11-25 21:14:40,373 DEBUG : BROWSER_OUTPUT: RSS: Main: 139247616 21:14:40 INFO - 2015-11-25 21:14:40,373 DEBUG : BROWSER_OUTPUT: 21:14:42 INFO - 2015-11-25 21:14:42,208 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40704/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40704/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:14:42 INFO - 2015-11-25 21:14:42,830 DEBUG : BROWSER_OUTPUT: RSS: Main: 139116544 21:14:42 INFO - 2015-11-25 21:14:42,830 DEBUG : BROWSER_OUTPUT: 21:14:44 INFO - 2015-11-25 21:14:44,927 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40704/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40704/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:14:45 INFO - 2015-11-25 21:14:45,520 DEBUG : BROWSER_OUTPUT: RSS: Main: 140029952 21:14:45 INFO - 2015-11-25 21:14:45,520 DEBUG : BROWSER_OUTPUT: 21:14:47 INFO - 2015-11-25 21:14:47,959 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40704/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40704/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:14:48 INFO - 2015-11-25 21:14:48,561 DEBUG : BROWSER_OUTPUT: RSS: Main: 138215424 21:14:48 INFO - 2015-11-25 21:14:48,561 DEBUG : BROWSER_OUTPUT: 21:14:51 INFO - 2015-11-25 21:14:51,145 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40704/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40704/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:14:51 INFO - 2015-11-25 21:14:51,731 DEBUG : BROWSER_OUTPUT: RSS: Main: 139247616 21:14:51 INFO - 2015-11-25 21:14:51,732 DEBUG : BROWSER_OUTPUT: 21:14:53 INFO - 2015-11-25 21:14:53,432 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40704/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40704/tests/kraken/driver.html?testName=ai-astar) 21:14:53 INFO - 2015-11-25 21:14:53,682 DEBUG : BROWSER_OUTPUT: RSS: Main: 138973184 21:14:53 INFO - 2015-11-25 21:14:53,682 DEBUG : BROWSER_OUTPUT: 21:14:53 INFO - 2015-11-25 21:14:53,682 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:14:53 INFO - 2015-11-25 21:14:53,682 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:14:53 INFO - 2015-11-25 21:14:53,682 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:14:53 INFO - 2015-11-25 21:14:53,683 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:14:53 INFO - 2015-11-25 21:14:53,683 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;105;111;111;113;124;112;112;111;112 21:14:53 INFO - 2015-11-25 21:14:53,683 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;126;150;177;128;149;153;127;173;129 21:14:53 INFO - 2015-11-25 21:14:53,683 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;162;164;162;162;162;161;165;167;164 21:14:53 INFO - 2015-11-25 21:14:53,683 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;73;73;71;71;71;125;72;72;71 21:14:53 INFO - 2015-11-25 21:14:53,683 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;92;136;93;92;97;145;92;93;135 21:14:53 INFO - 2015-11-25 21:14:53,683 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;109;110;109;110;111;110 21:14:53 INFO - 2015-11-25 21:14:53,684 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;146;146;147;146;146;146;148 21:14:53 INFO - 2015-11-25 21:14:53,684 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;96;97;96;96;96;96 21:14:53 INFO - 2015-11-25 21:14:53,684 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;64;63;61;65;63;62;62;59;64 21:14:53 INFO - 2015-11-25 21:14:53,684 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;71;71;70;70;70;70;70;70;71;71 21:14:53 INFO - 2015-11-25 21:14:53,684 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;85;84;97;86;91;86;84;85;84 21:14:53 INFO - 2015-11-25 21:14:53,684 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;113;120;122;127;119;119;119;121;125;117 21:14:53 INFO - 2015-11-25 21:14:53,684 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;144;148;154;150;157;144;151;155;142;144 21:14:53 INFO - 2015-11-25 21:14:53,685 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;67;68;69;68;66;67;70;67;69 21:14:53 INFO - 2015-11-25 21:14:53,685 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:14:53 INFO - 2015-11-25 21:14:53,685 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:14:53 INFO - 2015-11-25 21:14:53,685 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,742 21:14:53 INFO - 2015-11-25 21:14:53,685 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:14:53 INFO - 2015-11-25 21:14:53,685 DEBUG : BROWSER_OUTPUT: __startTimestamp1448514893681__endTimestamp 21:14:53 INFO - 2015-11-25 21:14:53,685 DEBUG : BROWSER_OUTPUT: 21:14:53 INFO - 2015-11-25 21:14:53,689 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:14:53 INFO - 2015-11-25 21:14:53,689 DEBUG : BROWSER_OUTPUT: Number of tests: 14 21:14:53 INFO - 2015-11-25 21:14:53,689 DEBUG : BROWSER_OUTPUT: 21:14:53 INFO - 2015-11-25 21:14:53,689 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.30 Median:112.00 stddev:4.67 (4.2%) stddev-sans-first:4.95 21:14:53 INFO - 2015-11-25 21:14:53,689 DEBUG : BROWSER_OUTPUT: Values: 112.0 105.0 111.0 111.0 113.0 124.0 112.0 112.0 111.0 112.0 21:14:53 INFO - 2015-11-25 21:14:53,690 DEBUG : BROWSER_OUTPUT: 21:14:53 INFO - 2015-11-25 21:14:53,690 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.90 Median:151.50 stddev:19.01 (12.5%) stddev-sans-first:19.80 21:14:53 INFO - 2015-11-25 21:14:53,690 DEBUG : BROWSER_OUTPUT: Values: 157.0 126.0 150.0 177.0 128.0 149.0 153.0 127.0 173.0 129.0 21:14:53 INFO - 2015-11-25 21:14:53,690 DEBUG : BROWSER_OUTPUT: 21:14:53 INFO - 2015-11-25 21:14:53,690 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.30 Median:164.00 stddev:1.83 (1.1%) stddev-sans-first:1.92 21:14:53 INFO - 2015-11-25 21:14:53,691 DEBUG : BROWSER_OUTPUT: Values: 164.0 162.0 164.0 162.0 162.0 162.0 161.0 165.0 167.0 164.0 21:14:53 INFO - 2015-11-25 21:14:53,691 DEBUG : BROWSER_OUTPUT: 21:14:53 INFO - 2015-11-25 21:14:53,691 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:76.90 Median:71.50 stddev:16.93 (23.7%) stddev-sans-first:17.77 21:14:53 INFO - 2015-11-25 21:14:53,691 DEBUG : BROWSER_OUTPUT: Values: 70.0 73.0 73.0 71.0 71.0 71.0 125.0 72.0 72.0 71.0 21:14:53 INFO - 2015-11-25 21:14:53,691 DEBUG : BROWSER_OUTPUT: 21:14:53 INFO - 2015-11-25 21:14:53,691 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.00 Median:92.50 stddev:22.06 (23.8%) stddev-sans-first:22.97 21:14:53 INFO - 2015-11-25 21:14:53,692 DEBUG : BROWSER_OUTPUT: Values: 95.0 92.0 136.0 93.0 92.0 97.0 145.0 92.0 93.0 135.0 21:14:53 INFO - 2015-11-25 21:14:53,692 DEBUG : BROWSER_OUTPUT: 21:14:53 INFO - 2015-11-25 21:14:53,692 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 21:14:53 INFO - 2015-11-25 21:14:53,692 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 109.0 110.0 109.0 110.0 111.0 110.0 21:14:53 INFO - 2015-11-25 21:14:53,692 DEBUG : BROWSER_OUTPUT: 21:14:53 INFO - 2015-11-25 21:14:53,692 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 21:14:53 INFO - 2015-11-25 21:14:53,693 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 148.0 21:14:53 INFO - 2015-11-25 21:14:53,693 DEBUG : BROWSER_OUTPUT: 21:14:53 INFO - 2015-11-25 21:14:53,693 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 21:14:53 INFO - 2015-11-25 21:14:53,693 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 96.0 97.0 96.0 96.0 96.0 96.0 21:14:53 INFO - 2015-11-25 21:14:53,693 DEBUG : BROWSER_OUTPUT: 21:14:53 INFO - 2015-11-25 21:14:53,693 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.60 Median:63.00 stddev:1.71 (2.7%) stddev-sans-first:1.81 21:14:53 INFO - 2015-11-25 21:14:53,693 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 63.0 61.0 65.0 63.0 62.0 62.0 59.0 64.0 21:14:53 INFO - 2015-11-25 21:14:53,693 DEBUG : BROWSER_OUTPUT: 21:14:53 INFO - 2015-11-25 21:14:53,693 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:70.50 stddev:0.52 (0.7%) stddev-sans-first:0.50 21:14:53 INFO - 2015-11-25 21:14:53,694 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 70.0 70.0 70.0 70.0 70.0 70.0 71.0 71.0 21:14:53 INFO - 2015-11-25 21:14:53,694 DEBUG : BROWSER_OUTPUT: 21:14:53 INFO - 2015-11-25 21:14:53,694 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:85.50 stddev:4.30 (5.0%) stddev-sans-first:4.37 21:14:53 INFO - 2015-11-25 21:14:53,694 DEBUG : BROWSER_OUTPUT: Values: 83.0 85.0 84.0 97.0 86.0 91.0 86.0 84.0 85.0 84.0 21:14:53 INFO - 2015-11-25 21:14:53,694 DEBUG : BROWSER_OUTPUT: 21:14:53 INFO - 2015-11-25 21:14:53,694 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.20 Median:120.50 stddev:3.94 (3.3%) stddev-sans-first:3.20 21:14:53 INFO - 2015-11-25 21:14:53,694 DEBUG : BROWSER_OUTPUT: Values: 113.0 120.0 122.0 127.0 119.0 119.0 119.0 121.0 125.0 117.0 21:14:53 INFO - 2015-11-25 21:14:53,694 DEBUG : BROWSER_OUTPUT: 21:14:53 INFO - 2015-11-25 21:14:53,695 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.90 Median:150.50 stddev:5.32 (3.5%) stddev-sans-first:5.34 21:14:53 INFO - 2015-11-25 21:14:53,695 DEBUG : BROWSER_OUTPUT: Values: 144.0 148.0 154.0 150.0 157.0 144.0 151.0 155.0 142.0 144.0 21:14:53 INFO - 2015-11-25 21:14:53,696 DEBUG : BROWSER_OUTPUT: 21:14:53 INFO - 2015-11-25 21:14:53,696 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.50 stddev:1.25 (1.8%) stddev-sans-first:1.27 21:14:53 INFO - 2015-11-25 21:14:53,696 DEBUG : BROWSER_OUTPUT: Values: 69.0 67.0 68.0 69.0 68.0 66.0 67.0 70.0 67.0 69.0 21:14:53 INFO - 2015-11-25 21:14:53,696 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:14:53 INFO - 2015-11-25 21:14:53,696 DEBUG : BROWSER_OUTPUT: 21:14:54 INFO - 2015-11-25 21:14:54,525 INFO : Browser exited with error code: 0 21:14:54 INFO - 2015-11-25 21:14:54,574 INFO : Completed test kraken (00:00:59) 21:14:54 INFO - 2015-11-25 21:14:54,574 INFO : Starting test v8_7 21:14:54 INFO - 2015-11-25 21:14:54,574 DEBUG : operating with platform_type : linux_ 21:14:54 INFO - 2015-11-25 21:14:54,574 INFO : Initialising browser for v8_7 test... 21:14:54 INFO - 2015-11-25 21:14:54,580 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4CvblZ/profile http://localhost:40704/getInfo.html 21:14:58 INFO - 2015-11-25 21:14:58,849 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:14:58 INFO - 2015-11-25 21:14:58,849 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:14:58 INFO - 2015-11-25 21:14:58,849 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:14:58 INFO - 2015-11-25 21:14:58,849 DEBUG : BROWSER_OUTPUT: __metrics 21:14:59 INFO - 2015-11-25 21:14:59,821 INFO : Browser initialized. 21:14:59 INFO - 2015-11-25 21:14:59,822 INFO : Running cycle 1/1 for v8_7 test... 21:14:59 INFO - 2015-11-25 21:14:59,822 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4CvblZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:15:11 INFO - 2015-11-25 21:15:11,601 DEBUG : BROWSER_OUTPUT: RSS: Main: 138272768 21:15:11 INFO - 2015-11-25 21:15:11,601 DEBUG : BROWSER_OUTPUT: 21:15:32 INFO - 2015-11-25 21:15:32,966 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40704/tests/v8_7/run.html (next: http://localhost:40704/tests/v8_7/run.html) 21:15:33 INFO - 2015-11-25 21:15:33,216 DEBUG : BROWSER_OUTPUT: RSS: Main: 137453568 21:15:33 INFO - 2015-11-25 21:15:33,216 DEBUG : BROWSER_OUTPUT: 21:15:33 INFO - 2015-11-25 21:15:33,218 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:15:33 INFO - 2015-11-25 21:15:33,218 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:15:33 INFO - 2015-11-25 21:15:33,218 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:15:33 INFO - 2015-11-25 21:15:33,218 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:15:33 INFO - 2015-11-25 21:15:33,218 DEBUG : BROWSER_OUTPUT: |0;Richards;175.7469244288225 21:15:33 INFO - 2015-11-25 21:15:33,218 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.9487975174554 21:15:33 INFO - 2015-11-25 21:15:33,218 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.7142857142857 21:15:33 INFO - 2015-11-25 21:15:33,219 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5133.333333333333 21:15:33 INFO - 2015-11-25 21:15:33,219 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1081.081081081081 21:15:33 INFO - 2015-11-25 21:15:33,219 DEBUG : BROWSER_OUTPUT: |5;Earley;710.7320540156361 21:15:33 INFO - 2015-11-25 21:15:33,219 DEBUG : BROWSER_OUTPUT: |6;Boyer;12096.385542168675 21:15:33 INFO - 2015-11-25 21:15:33,219 DEBUG : BROWSER_OUTPUT: |7;RegExp;24902.439024390245 21:15:33 INFO - 2015-11-25 21:15:33,219 DEBUG : BROWSER_OUTPUT: |8;Splay;642.1725239616613 21:15:33 INFO - 2015-11-25 21:15:33,220 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 21:15:33 INFO - 2015-11-25 21:15:33,220 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:15:33 INFO - 2015-11-25 21:15:33,220 DEBUG : BROWSER_OUTPUT: __startTimestamp1448514933216__endTimestamp 21:15:33 INFO - 2015-11-25 21:15:33,220 DEBUG : BROWSER_OUTPUT: 21:15:33 INFO - 2015-11-25 21:15:33,220 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:15:33 INFO - 2015-11-25 21:15:33,221 DEBUG : BROWSER_OUTPUT: Number of tests: 10 21:15:33 INFO - 2015-11-25 21:15:33,221 DEBUG : BROWSER_OUTPUT: 21:15:33 INFO - 2015-11-25 21:15:33,221 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:175.75 Median:175.75 stddev:0.00 (0.0%) 21:15:33 INFO - 2015-11-25 21:15:33,221 DEBUG : BROWSER_OUTPUT: Values: 175.7 21:15:33 INFO - 2015-11-25 21:15:33,221 DEBUG : BROWSER_OUTPUT: 21:15:33 INFO - 2015-11-25 21:15:33,221 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.95 Median:193.95 stddev:0.00 (0.0%) 21:15:33 INFO - 2015-11-25 21:15:33,221 DEBUG : BROWSER_OUTPUT: Values: 193.9 21:15:33 INFO - 2015-11-25 21:15:33,221 DEBUG : BROWSER_OUTPUT: 21:15:33 INFO - 2015-11-25 21:15:33,222 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.71 Median:285.71 stddev:0.00 (0.0%) 21:15:33 INFO - 2015-11-25 21:15:33,222 DEBUG : BROWSER_OUTPUT: Values: 285.7 21:15:33 INFO - 2015-11-25 21:15:33,222 DEBUG : BROWSER_OUTPUT: 21:15:33 INFO - 2015-11-25 21:15:33,222 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 21:15:33 INFO - 2015-11-25 21:15:33,222 DEBUG : BROWSER_OUTPUT: Values: 5133.3 21:15:33 INFO - 2015-11-25 21:15:33,223 DEBUG : BROWSER_OUTPUT: 21:15:33 INFO - 2015-11-25 21:15:33,223 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1081.08 Median:1081.08 stddev:0.00 (0.0%) 21:15:33 INFO - 2015-11-25 21:15:33,223 DEBUG : BROWSER_OUTPUT: Values: 1081.1 21:15:33 INFO - 2015-11-25 21:15:33,223 DEBUG : BROWSER_OUTPUT: 21:15:33 INFO - 2015-11-25 21:15:33,223 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:710.73 Median:710.73 stddev:0.00 (0.0%) 21:15:33 INFO - 2015-11-25 21:15:33,223 DEBUG : BROWSER_OUTPUT: Values: 710.7 21:15:33 INFO - 2015-11-25 21:15:33,224 DEBUG : BROWSER_OUTPUT: 21:15:33 INFO - 2015-11-25 21:15:33,224 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12096.39 Median:12096.39 stddev:0.00 (0.0%) 21:15:33 INFO - 2015-11-25 21:15:33,224 DEBUG : BROWSER_OUTPUT: Values: 12096.4 21:15:33 INFO - 2015-11-25 21:15:33,224 DEBUG : BROWSER_OUTPUT: 21:15:33 INFO - 2015-11-25 21:15:33,224 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24902.44 Median:24902.44 stddev:0.00 (0.0%) 21:15:33 INFO - 2015-11-25 21:15:33,225 DEBUG : BROWSER_OUTPUT: Values: 24902.4 21:15:33 INFO - 2015-11-25 21:15:33,225 DEBUG : BROWSER_OUTPUT: 21:15:33 INFO - 2015-11-25 21:15:33,226 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:642.17 Median:642.17 stddev:0.00 (0.0%) 21:15:33 INFO - 2015-11-25 21:15:33,226 DEBUG : BROWSER_OUTPUT: Values: 642.2 21:15:33 INFO - 2015-11-25 21:15:33,226 DEBUG : BROWSER_OUTPUT: 21:15:33 INFO - 2015-11-25 21:15:33,226 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 21:15:33 INFO - 2015-11-25 21:15:33,227 DEBUG : BROWSER_OUTPUT: Values: 4840.6 21:15:33 INFO - 2015-11-25 21:15:33,227 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:15:33 INFO - 2015-11-25 21:15:33,227 DEBUG : BROWSER_OUTPUT: 21:15:34 INFO - 2015-11-25 21:15:34,013 INFO : Browser exited with error code: 0 21:15:34 INFO - 2015-11-25 21:15:34,028 INFO : Completed test v8_7 (00:00:39) 21:15:34 INFO - 2015-11-25 21:15:34,282 INFO : Completed test suite (00:20:10) 21:15:34 INFO - 2015-11-25 21:15:34,282 DEBUG : Working with test: dromaeo_css 21:15:34 INFO - 2015-11-25 21:15:34,282 DEBUG : Generating results file: dromaeo_css 21:15:34 INFO - 2015-11-25 21:15:34,283 DEBUG : Working with test: kraken 21:15:34 INFO - 2015-11-25 21:15:34,283 DEBUG : Generating results file: kraken 21:15:34 INFO - 2015-11-25 21:15:34,284 INFO : javascript benchmark 21:15:34 INFO - 2015-11-25 21:15:34,284 DEBUG : Working with test: v8_7 21:15:34 INFO - 2015-11-25 21:15:34,284 DEBUG : Generating results file: v8_7 21:15:34 INFO - 2015-11-25 21:15:34,284 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:15:34 INFO - 2015-11-25 21:15:34,375 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 21:15:34 INFO - 2015-11-25 21:15:34,375 DEBUG : process_Request line: dromaeo_css 7052.80 graph.html#tests=[[72,64,43]] 21:15:34 INFO - 2015-11-25 21:15:34,375 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:15:34 INFO - 2015-11-25 21:15:34,535 DEBUG : process_Request line: kraken 1515.20 graph.html#tests=[[232,64,43]] 21:15:34 INFO - 2015-11-25 21:15:34,535 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:15:34 INFO - 2015-11-25 21:15:34,666 DEBUG : process_Request line: v8_7 21078.85 graph.html#tests=[[230,64,43]] 21:15:34 INFO - 2015-11-25 21:15:34,667 INFO : javascript benchmark 21:15:34 INFO - 2015-11-25 21:15:34,671 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3225.193701574606, 3281.8030918144914, 3294.1105901406604, 3322.451795453751, 3340.1315657928944, 5256.053910296155, 5408.972955135224, 5438.8912221755545, 5462.453754624536, 5476.616636835418, 5340.759665815038, 5387.353517577896, 5420.4850539198715, 5421.457854214576, 5439.292891924054, 4682.742449165295, 4976.502349765031, 5025.0703619830265, 5040.747962601874, 5082.745862706868, 4848.224284114543, 5000.899982000358, 5008.699478031312, 5050.595952323823, 5063.8480845574695, 4760.8333708320215, 4931.531504507102, 4945.0, 4969.055879382906, 4971.254311853215, 4987.476314986947, 5033.697978121324, 5048.040872234264, 5063.594912406998, 5086.262491938648, 4784.186688263004, 4870.805167793284, 4984.700917944935, 4994.82518111868, 5092.185250359925, 4997.575206107485, 5219.243209734605, 5241.580673546107, 5309.203619457074, 5385.865353366158, 5903.439173278532, 5910.113482977587, 5921.0, 5933.169356290123, 5935.970320148414, 5726.5705072119345, 5865.736041878125, 5866.530677545828, 5950.256217972754, 5994.220751302347, 5450.727463626803, 5468.316460442445, 5504.6421982571, 5505.559555235612, 5508.14623733318, 5877.0, 5885.323187833368, 5940.257467816523, 5942.0, 5954.940450595525, 5866.560007999417, 5873.442023007808, 5881.382454842265, 5893.027650437715, 5920.378360272195, 5860.09168578871, 5922.200502932049, 5959.970200148971, 5962.791302304398, 5974.253218347707, 5672.602917795797, 5817.389174136655, 5825.2135961644635, 5927.9407205928255, 5946.583739138218, 5896.469317761336, 5906.704664766745, 5907.852303692442, 5916.408359164049, 5936.7922122725495, 4546.02260513991, 4553.248713962225, 4555.498895121534, 4567.406237189144, 4599.33309670096, 3966.6231707987695, 3971.821268042945, 4046.2918989177365, 4055.5538890721996, 4112.177564487115, 5618.775248989995, 5649.971750141223, 5663.9716801415725, 5671.631343962629, 5687.0, 5930.584859059824, 5948.137520059568, 5950.7917222896995, 5968.403159683997, 5982.73077711504, 5406.08096623575, 5500.642458240201, 5563.554915606823, 5636.689982051026, 5735.598508104476, 5165.612579056586, 5198.610104242197, 5212.348456442945, 5212.713300768418, 5224.0, 6102.816915492543, 6125.264968203844, 6139.570230083851, 6141.570090093651, 6154.415330543591, 5759.971200143972, 5819.6508209507565, 5929.851753706192, 5935.4064593542025, 5945.078512830518, 6102.658667634139, 6120.6299886969155, 6139.815805525842, 6144.907826382697, 6153.600015998945, 5800.158976948234, 5851.034579294369, 5855.268091488564, 5881.264841894763, 5890.410958904075, 5763.221965034834, 5782.508486778671, 5895.764169433174, 5946.07835785454, 5958.702064896825, 5705.7147142643535, 5712.885742285048, 5718.485336319751, 5724.398938111605, 5728.054870946247, 5675.0, 5708.6574805510145, 5729.512991395778, 5730.5702072345575, 5757.625754325955, 5473.562115030868, 5529.336479622471, 5621.072523033654, 5628.437156284339, 5748.712564371848, 5778.306603207642, 5793.188953546591, 5798.391168927202, 5808.39011903744, 5826.76692932278, 5640.351359593699, 5676.290463692038, 5713.742881570256, 5716.828495145152, 5718.628289161191], "unit": "ms", "name": "dojo.html", "value": 5425.324228580239}, {"lowerIsBetter": false, "replicates": [532.1830989431223, 561.8146011816101, 569.5585920911293, 572.4447286132452, 606.0908637044433, 31750.841245793767, 41530.0, 42034.7898260509, 42238.366424503656, 42408.0, 44639.0, 44997.0, 45202.32196517055, 45207.0, 45291.77354113225, 8658.350623703216, 8843.469391836477, 8853.070427605106, 8891.911080889173, 8954.910450895473, 8679.826403471958, 8825.779355516132, 8829.735107946772, 8830.0, 8836.513991730451, 8844.867326990101, 8945.64217431302, 8982.101789820998, 8990.011098779129, 8995.145461181177, 8767.167119123706, 8839.204471597555, 8862.778430539223, 8902.86645700315, 8918.152775486318, 8778.0, 8872.423292485968, 8877.245434138105, 8892.555372231363, 8908.287337013024, 41184.38223426651, 41563.376549351786, 41642.167156657, 41868.0, 41997.37003944943, 3258.7881787683964, 3344.0803778960735, 3586.55168103987, 3689.760165589228, 4040.7575545467366, 30560.0, 30687.386252275053, 31441.37117257642, 31563.684363156535, 32352.352952940808, 3800.1639639279592, 3808.257389808961, 3830.636089571486, 3852.171783066626, 3916.0797212655, 272891.0, 273097.0, 273562.63218683976, 274270.0, 274897.0, 54493.45506544884, 55427.0, 60258.78188526849, 60755.0, 68513.0, 65754.67122664451, 65845.34154658488, 65917.67041164859, 66045.33954660488, 66113.33886661168, 15943.840561594468, 15969.0, 16065.357385704441, 16130.435434759727, 16156.838431615533, 12310.569130080405, 12315.568955086528, 12349.876501235052, 12392.442340094718, 12424.937875310565, 20976.685349719766, 21092.578148437253, 21199.0, 21207.0, 21230.36308910735, 7795.844083118419, 7981.64082616272, 7990.2893707572475, 8059.758207253792, 8082.919170808216, 940.6378544260372, 976.1263669016191, 1010.2019404670375, 1029.3772267777886, 1100.1418893263267, 28842.134735957956, 29198.416031679673, 29564.0, 29799.40401191964, 29924.850375748418, 1003.0370843989851, 1033.6382266206917, 1073.5974009746344, 1088.8257878739523, 1102.8841971593029, 13894.374753136133, 14225.64435889111, 15881.444149454945, 16164.110973896548, 16616.418425355056, 325584.0, 325874.0, 327197.0, 328619.0, 329858.0, 54499.0, 54524.18213726797, 54670.453295467334, 54708.452915471134, 55057.0, 1328.8073229381685, 1362.3120324236197, 1364.8566900475505, 1366.4875671623142, 1370.0683535195963, 29386.11841644754, 29509.704902951555, 30460.84769576138, 31515.21211969719, 31721.682783171873, 51003.0, 51258.74370628123, 51480.74259628678, 51649.741751291, 51814.0, 285217.0, 287683.0, 287814.0, 288000.0, 288024.0, 32185.678143219204, 32971.51628176786, 33232.0, 33280.833595831864, 33304.1673958153, 39877.601223988546, 40438.393424098074, 40460.1907961845, 40514.1897162061, 40826.0, 34082.82958585191, 34231.144221394665, 34775.826120870246, 38064.0, 38677.6132238674, 33610.327793444485, 33908.66091339055, 33997.980060598224, 34501.654983449844, 34541.48187777135, 34154.14614634654, 37013.0, 37149.25701486009, 37506.0, 37565.43651845279, 28832.279193020342, 30789.23026924345, 31773.523397148598, 31804.68195318017, 31844.68155318417, 24061.879690601436, 24128.155514556907, 24211.878940605184, 24478.265652030466, 24548.877255613606], "unit": "ms", "name": "ext.html", "value": 18890.464627086436}, {"lowerIsBetter": false, "replicates": [324.94800831866894, 349.4129861832121, 350.831600831601, 353.6163262859797, 356.7787971457696, 16713.665726685475, 17046.74429883551, 17764.822351776478, 18169.273229070855, 18738.344157954474, 9633.08485693858, 9638.951805240982, 9641.758956026102, 10211.591536338556, 10429.634962776305, 4969.527894849984, 4988.526090021452, 5119.974400127994, 5141.5886729061585, 5152.665076770017, 5028.874278143039, 5068.74656267187, 5072.0, 5073.873153171182, 5075.796968121271, 5029.597632189416, 5058.392992840864, 5067.670601410915, 5070.569001634865, 5199.14214154664, 5102.795888164469, 5146.459621739719, 5156.381234251876, 5160.2517634942915, 5161.458046905077, 4810.06203790261, 4853.39332583427, 4862.17343051682, 4864.756762161913, 4887.853364399074, 12612.243265404106, 12803.679908002374, 15643.687126257524, 21360.0, 21392.25127120559, 2026.3414390323057, 2107.2729908181655, 2164.9134034638596, 2188.3325585696357, 2217.135317226283, 9675.274354423376, 9883.802323953552, 10084.042016008467, 10905.618303359424, 13701.931490342584, 1896.3931541906595, 1910.4841692742882, 1914.3969649560345, 1916.645420597194, 1923.413358925527, 61187.69406152941, 62644.686776565824, 64356.67821660862, 64374.0, 65535.672321638085, 9810.558524866397, 10102.595896164217, 10272.126869216201, 10297.433641149659, 10339.586416543254, 13401.932990334986, 13443.932780336036, 13462.86537134616, 13463.192208467523, 13471.92224622028, 7750.7674769756995, 7750.922490775133, 7772.145064042951, 7827.921720782833, 7837.568933708701, 7561.7731468056045, 7586.468947173756, 7591.3547348475995, 7643.235676432312, 7700.075990881131, 4378.255696531597, 4390.0, 4403.9559604404185, 4414.161309351213, 4418.2047231498, 1638.2382192280647, 1657.4364715996378, 1664.0265444714735, 1672.5316911264865, 1681.201429321087, 414.3246508191689, 422.81818817908595, 427.05833636831335, 432.08182611949604, 465.0698602794411, 10559.260851740459, 16487.752683709754, 17022.0, 17103.14484275781, 17445.302187912595, 886.4415418286567, 913.0823522359985, 937.9859302110474, 956.2445667922402, 1015.9325772053983, 9451.243900488082, 9466.337356384987, 9617.23062155026, 9634.277429192838, 9682.225421966226, 548901.0, 557253.0, 559525.0, 573869.0, 578906.0, 79420.0, 80905.59547202344, 82447.17552824515, 82851.0, 84995.5750221245, 1133.9659810205708, 1142.891365430779, 1147.6786499780076, 1164.8078067118831, 1174.7004513848915, 14849.92575037118, 15502.612434689223, 15582.688346233239, 15608.205056418657, 15632.06207627546, 32817.67182328146, 33077.50383744294, 33226.0, 33949.66050339564, 34443.13892152716, 45540.07978962714, 45764.0, 48091.75954120347, 49400.50599493959, 50887.2366914504, 9084.364094513585, 9486.857697134687, 9537.380070295409, 9608.183304418922, 9647.855282170913, 11169.72075698114, 14521.419143234574, 16973.23620437108, 17203.827961720723, 17458.47624571214, 13680.863191367958, 14367.066140700821, 14387.712245755236, 14468.493602723855, 14946.476873309817, 14134.363953621905, 14143.363548640542, 14467.0, 14474.927625361806, 14729.0, 14867.776983345475, 15100.848991509944, 15281.541553753405, 15587.142707151215, 15622.609434764221, 9351.345405821527, 9359.391639543408, 9435.858462122937, 9547.76130596713, 9567.9043209567, 9982.338325832816, 14729.55811325662, 14878.776818347516, 14973.176475293963, 15070.095794251942], "unit": "ms", "name": "jquery.html", "value": 8491.818128285699}, {"lowerIsBetter": false, "replicates": [1474.0787008119926, 1513.8259100203472, 1575.5588435238137, 1652.1161178769353, 1752.0, 7299.927000729991, 7460.813479663011, 7556.093268807744, 7655.846883062335, 7698.268664476873, 7693.615319234043, 7748.341390981774, 7749.457537972344, 7811.531308121516, 7823.0, 2195.2536137713137, 2205.492736670567, 2219.2343641443676, 2222.744384395791, 2223.6998005269324, 2277.7266727992583, 2312.1213938703354, 2312.7455979842202, 2315.455867871049, 2317.6639387288833, 2127.8723276603378, 2180.1933284684687, 2200.471886747177, 2268.5349503351854, 2293.5986202414592, 2257.887105644711, 2258.920937767187, 2284.6344584866424, 2298.7931086202157, 2303.5968705476557, 2325.9069637214493, 2335.859848409101, 2350.74141844397, 2355.1639168095253, 2358.2099996501192, 7519.097708274987, 7592.164861865191, 7598.392128629696, 7607.923920760777, 7620.428467864932, 4693.366395536593, 4747.52524747526, 4782.13921494131, 4782.258749893737, 4800.231962885921, 3033.1810411189076, 3053.1451193665807, 3079.16862447138, 3105.7825952183357, 3121.672224416426, 1034.6068493972243, 1035.0425856083093, 1062.2564205056492, 1118.9496472658668, 1878.2205384765307, 10060.748481287954, 10129.848052279222, 10132.645357412455, 10145.44200068996, 10158.695239142764, 4239.894002649897, 4266.530681625019, 4400.559944005574, 4428.756418396954, 4452.0428107956295, 8778.780530486789, 8834.116588341114, 8845.778855528662, 8854.513001784835, 8878.955605221932, 4751.287306903992, 4818.10864989978, 4822.565969062801, 4841.830535931225, 4856.490068542752, 4379.890502737393, 4380.14587155508, 4384.868453946387, 4396.472423309159, 4420.447444069491, 3581.982090089585, 3662.7252956028406, 3684.9447258291148, 3691.0956815579816, 3709.925801483955, 1192.3501691577937, 1198.1373411143963, 1204.5302332090491, 1212.0485418946262, 1219.0674134287278, 976.6142373762324, 1030.006044167382, 1146.9677290438506, 1234.4383305595932, 1374.0793668242302, 6938.306169383021, 7104.964475177694, 7119.696242135022, 7160.212376638566, 7167.139943206848, 587.7737071227608, 602.2592211579781, 608.9786857459968, 609.439315829438, 765.7938746474325, 5379.381371142291, 5434.130539113723, 5445.59158063139, 5469.124940009579, 5474.042042642522, 8866.290696744245, 8960.820783584291, 9154.542272886461, 9283.72148835536, 9337.253019758538, 9080.0, 9124.680636177702, 9168.26653867689, 9170.633174673072, 9250.814983700287, 6956.686949087303, 7123.501354905211, 7187.38907192884, 7199.460040496983, 7271.963640181871, 7185.928140718526, 7199.3520583147765, 7216.170140433707, 7248.166460857069, 7260.237675044044, 8028.197180281925, 8229.46508476947, 8291.62687679068, 8291.668333266602, 8316.584170791557, 8340.124286949784, 8397.874031889649, 8409.87385189235, 8416.452930559493, 8450.704225352083, 6488.805335839932, 6551.050097735897, 6622.4702023838945, 6725.831854203489, 6768.390844823793, 7073.115860517435, 7100.183478899992, 7123.536970096927, 7129.536580122275, 7129.750458734127, 6575.210974683068, 6579.671016449062, 6732.899006515004, 6766.661666916536, 6855.554388964901, 6681.265060843206, 6699.095622090956, 6738.326167383222, 6830.180378354629, 6849.2808255132495, 6638.269790322964, 6767.966160169168, 6782.084418603426, 6782.423494003065, 6799.6600169990315, 6198.504119670325, 6201.627902325875, 6218.471429928507, 6240.313565507699, 6241.625502469867, 6304.527160463075, 6350.460210882126, 6394.040893865771, 6414.0, 6435.613863168225], "unit": "ms", "name": "mootools.html", "value": 4391.018564779439}, {"lowerIsBetter": false, "replicates": [307.1231633685827, 333.0890015806768, 339.7180340317537, 343.54308769336785, 345.22496994247916, 6306.117143599894, 6311.274203466603, 6361.332060133689, 6372.267189273235, 6431.292557818636, 6119.877602447948, 6267.4672652824565, 6287.245530536331, 6291.653959032252, 6293.748250069992, 4796.664233503656, 4809.134355815969, 4814.54261845125, 4815.470298267188, 4821.590164835993, 4816.422029356482, 4819.831305904294, 4827.420709514863, 4833.879153021167, 4838.225883858583, 4685.976570117145, 4767.523247675222, 4780.259059845712, 4786.066716990188, 4787.521247875202, 4777.641676874231, 4779.976100119512, 4783.0, 4787.066522028206, 4793.784279707422, 4118.670506359514, 4121.175764847043, 4127.195196936568, 4130.772807495587, 4137.50349958004, 5966.194563733884, 5982.46157845796, 5989.670568118751, 5991.221141251609, 6000.6399616022745, 5418.7019713915715, 5535.308086489189, 5536.833894983117, 5548.445155484419, 5552.888942221173, 6644.634545100018, 6657.1345725055435, 6666.899996500057, 6675.46596272297, 6691.6319602421845, 4576.222042252825, 4584.770761461914, 4596.080783843211, 4601.585857272828, 4607.470140933769, 6770.255271920085, 6881.208661003949, 6933.445324374038, 6951.617661028641, 6952.2352541220935, 4606.907861842745, 4611.962308480565, 4621.722696638212, 4632.745199014086, 4648.628109751212, 4703.811847526129, 4716.6698331116495, 4720.45714742809, 4721.3390125382475, 4721.551452611996, 5481.479259470424, 5494.066008778517, 5496.780128794803, 5500.917486237709, 5508.779648814083, 6512.967435162794, 6564.8358791030605, 6575.145231119924, 6628.4697224221945, 6637.668116594247, 1632.7877375941289, 1654.8676105911497, 1660.0703605980689, 1672.9498115056567, 1674.5646132005766, 1090.6564432203832, 1097.5061222449929, 1098.0666433531435, 1101.2566517600749, 1112.1825458288151, 6292.552712876064, 6305.180326557518, 6310.0850376695125, 6355.968220158869, 6378.649174295459, 6814.829629259309, 6826.4538836892925, 6826.829329266808, 6829.385355318045, 6835.7949261522235, 6202.317745048041, 6299.488122850575, 6360.459360954278, 6376.713047912763, 6378.532937424418, 3701.0377301901162, 3726.124360775216, 3738.0841693785196, 3741.9251614967548, 3749.1002159481527, 7068.787936361918, 7069.081019467436, 7072.7524536642, 7096.680649370791, 7117.288271172842, 6901.447884169254, 6986.476014298846, 6997.300269973064, 7002.40479559233, 7018.473614478935, 7258.673359698826, 7262.201157872735, 7267.091613548307, 7272.381847543018, 7300.342969132804, 6963.9303606963285, 6972.337627925339, 6975.860482790417, 6976.534927665247, 6977.372036516738, 6776.593404395752, 6789.083473730983, 6823.795286141423, 6885.0, 6933.861322773415, 7243.0946131733535, 7250.818729531804, 7251.709931602677, 7262.128544574685, 7264.0, 4672.57946784791, 4711.693739906895, 4722.1028004679, 4725.480197178239, 4731.526847315241, 6785.89821152693, 6927.203371612329, 6956.165260168812, 6961.7215311389, 6991.405730512964, 6751.324867513209, 6797.93202067973, 6802.93197068023, 6807.0810440589885, 6818.147731533559, 6747.359000894907, 6781.457483401217, 6790.25307216196, 6794.422474089758, 6798.8640227196165, 6528.347165283433, 6592.538522303585, 6627.768028118992, 6633.535652504278, 6635.568688035262, 6784.864302714017, 6795.456363491007, 6797.9945915955905, 6808.080909077211, 6819.488538359544, 6554.63949482783, 6559.147310849559, 6573.211214654272, 6579.736810527525, 6583.0454584086], "unit": "ms", "name": "prototype.html", "value": 5016.990303045352}, {"lowerIsBetter": false, "replicates": [743.6876511865016, 771.8533478639058, 792.1484404265416, 847.7753395350229, 849.7026040885695, 13812.240326782035, 14287.142771433708, 14290.928545357285, 14318.355673994656, 14373.065750726195, 13188.0, 13347.733045339111, 13382.799258011113, 13422.463101475954, 13438.395272212749, 829.5769157729571, 846.3905987688885, 849.1678155407704, 853.4580541356253, 858.8883445152153, 843.9789005274887, 848.817504236589, 849.8555245608261, 850.4812064640564, 851.4891065360796, 883.2757139145903, 892.5849479991803, 895.042304733935, 896.2471523919907, 897.7172190759923, 874.3704532736483, 881.1672969044256, 886.7561420609352, 887.742554659148, 891.7280229529958, 658.0688326018678, 661.2032500836481, 663.1611012069735, 664.830468230603, 664.9900251496232, 13584.388702508411, 13798.379072941741, 13821.861781382258, 13859.099158554662, 13862.93068534661, 12137.757244855142, 12186.268823870596, 12312.569060082855, 12738.745225095447, 12756.872431275755, 10200.846987295197, 10318.0, 10362.689119326433, 10542.36745795247, 10611.84082238767, 3564.0733409313766, 3622.963770362289, 3627.0, 3652.3243200008083, 3702.666759991587, 51607.0, 51647.483525164644, 51696.48303516954, 51785.482145178445, 51894.0, 10052.145567626834, 10424.113950314157, 10482.161427085815, 10485.685429436977, 10706.78586428267, 17822.5544361392, 17852.19665115073, 17852.821471785115, 17857.642847142983, 17912.731309030376, 7227.602481863443, 7275.490715649854, 7763.92236077632, 7797.064352277763, 7803.492772969739, 4193.496780386312, 4282.314829627245, 4369.191699535596, 4381.3208952612395, 4383.320585309282, 3066.7853250272715, 3075.400296942075, 3086.830224337683, 3104.4101620691995, 3105.3013072058607, 542.6472792684708, 545.939946605873, 555.8138023762004, 561.0658254007033, 564.7261078377066, 608.8264844519291, 639.4596565901805, 652.2531701202192, 653.8823011857911, 705.9647017649097, 7913.683452661944, 8010.439269251096, 8043.994500687414, 8066.798330041796, 8312.0, 553.5543887170866, 630.2468550082607, 675.2336098528108, 683.2723149845399, 688.2994052895062, 3791.336516109725, 3801.4487899255005, 3852.9807350963624, 3908.7459315144424, 3914.569397366344, 52827.73586132045, 63823.0, 63934.0, 63971.36028639654, 64286.67856660687, 49147.43532181927, 49913.0, 50101.24848127281, 50565.49434505682, 50856.23715644268, 48975.0, 49364.25953610627, 49414.0, 50047.74976125096, 50430.0, 8334.791630209293, 8474.1949514796, 8740.475571465733, 8856.202941735275, 8930.330225233003, 34760.82619586886, 35525.28949420946, 35565.46651800173, 35618.821905890305, 35943.28113437769, 49286.0, 49343.506564933894, 49972.50192486491, 49994.500054998985, 50172.498275018246, 10314.43270620123, 10977.945110274717, 11031.338119712844, 11035.889641103808, 11396.658100257006, 11755.941220293844, 11947.820782688093, 11996.280223186637, 12133.817992729939, 12640.241585504898, 11266.098712103176, 11296.152788541056, 11358.432078395881, 11509.597164099216, 11936.343501107522, 11065.834012489659, 11269.549218031187, 11315.603953861575, 11689.473973671034, 11706.063514918616, 11394.37330946806, 11513.424328783694, 11874.465649045986, 11926.463309150935, 11956.940215298868, 9598.85601715961, 9679.951600241953, 9898.257630677872, 10236.232282578985, 10365.429901355195, 8670.257641637822, 8928.821423571622, 9202.815943680955, 9740.172085372822, 9883.555240014073], "unit": "ms", "name": "yui.html", "value": 6418.7837166600875}], "name": "dromaeo_css", "value": 7052.796547092691}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 105.0, 111.0, 111.0, 113.0, 124.0, 112.0, 112.0, 111.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [157.0, 126.0, 150.0, 177.0, 128.0, 149.0, 153.0, 127.0, 173.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.9}, {"lowerIsBetter": true, "replicates": [164.0, 162.0, 164.0, 162.0, 162.0, 162.0, 161.0, 165.0, 167.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 163.3}, {"lowerIsBetter": true, "replicates": [70.0, 73.0, 73.0, 71.0, 71.0, 71.0, 125.0, 72.0, 72.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 76.9}, {"lowerIsBetter": true, "replicates": [95.0, 92.0, 136.0, 93.0, 92.0, 97.0, 145.0, 92.0, 93.0, 135.0], "unit": "ms", "name": "audio-oscillator", "value": 107.0}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0, 111.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 61.0, 65.0, 63.0, 62.0, 62.0, 59.0, 64.0], "unit": "ms", "name": "json-parse-financial", "value": 62.6}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 70.0, 70.0, 70.0, 70.0, 70.0, 70.0, 71.0, 71.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 70.4}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 84.0, 97.0, 86.0, 91.0, 86.0, 84.0, 85.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.5}, {"lowerIsBetter": true, "replicates": [113.0, 120.0, 122.0, 127.0, 119.0, 119.0, 119.0, 121.0, 125.0, 117.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.2}, {"lowerIsBetter": true, "replicates": [144.0, 148.0, 154.0, 150.0, 157.0, 144.0, 151.0, 155.0, 142.0, 144.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.9}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 68.0, 69.0, 68.0, 66.0, 67.0, 70.0, 67.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1515.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [175.7469244288225], "unit": "score", "name": "Richards", "value": 200.86838000000003}, {"lowerIsBetter": false, "replicates": [193.9487975174554], "unit": "score", "name": "DeltaBlue", "value": 340.90440800000005}, {"lowerIsBetter": false, "replicates": [285.7142857142857], "unit": "score", "name": "Encrypt", "value": 931.6335000000004}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [1081.081081081081], "unit": "score", "name": "RayTrace", "value": 684.4898250000002}, {"lowerIsBetter": false, "replicates": [710.7320540156361], "unit": "score", "name": "Earley", "value": 937.7134409999999}, {"lowerIsBetter": false, "replicates": [12096.385542168675], "unit": "score", "name": "Boyer", "value": 55.096044820717125}, {"lowerIsBetter": false, "replicates": [24902.439024390245], "unit": "score", "name": "RegExp", "value": 36.58215964740448}, {"lowerIsBetter": false, "replicates": [642.1725239616613], "unit": "score", "name": "Splay", "value": 126.89892039800993}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21078.84638932741}]} 21:15:34 INFO - RETURN: dromaeo_css: 7052.80 21:15:34 INFO - RETURN: kraken: 1515.20 21:15:34 INFO - RETURN: v8_7: 21078.85 21:15:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21078.85"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1515.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "7052.80"}}} 21:15:34 INFO - Return code: 0 21:15:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 21:15:34 INFO - # TBPL SUCCESS # 21:15:34 INFO - Running post-action listener: _resource_record_post_action 21:15:34 INFO - Running post-run listener: _resource_record_post_run 21:15:35 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 516096; Write bytes: 278134784; Read time: 140; Write time: 164104 21:15:35 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 4575232; Read time: 0; Write time: 340 21:15:35 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 516096; Write bytes: 273559552; Read time: 140; Write time: 163764 21:15:35 INFO - Running post-run listener: _upload_blobber_files 21:15:35 INFO - Blob upload gear active. 21:15:35 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 21:15:35 INFO - Copying logs to upload dir... 21:15:35 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1259.911708 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2015-11-25 21:15:35.603207) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 21:15:35.608558) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1448513179.325936-1778087941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/AwZkoj0iQve-XkbXO1h25g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009950 build_url: 'https://queue.taskcluster.net/v1/task/AwZkoj0iQve-XkbXO1h25g/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-25 21:15:35.660166) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 21:15:35.660579) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1448513179.325936-1778087941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004584 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 21:15:35.710157) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 21:15:35.710508) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 21:15:35.710842) ========= ========= Total master_lag: 0.67 =========